{"level":"warn","ts":"2026-05-05T15:32:37.501185Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T15:32:37.501281Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-05-05T15:32:37.501352Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T15:32:37.501372Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]}
{"level":"info","ts":"2026-05-05T15:32:37.501388Z","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-05-05T15:32:37.502024Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]}
{"level":"info","ts":"2026-05-05T15:32:37.502093Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-05-05T15:32:37.506396Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.105317ms"}
{"level":"info","ts":"2026-05-05T15:32:37.514766Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"}
{"level":"info","ts":"2026-05-05T15:32:37.514847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T15:32:37.514874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"}
{"level":"info","ts":"2026-05-05T15:32:37.51489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T15:32:37.514899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"}
{"level":"info","ts":"2026-05-05T15:32:37.514943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"}
{"level":"warn","ts":"2026-05-05T15:32:37.529027Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T15:32:37.530672Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T15:32:37.531781Z","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-05-05T15:32:37.534636Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T15:32:37.534852Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T15:32:37.535034Z","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-05-05T15:32:37.53518Z","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-05-05T15:32:37.535222Z","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-05-05T15:32:37.536337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"}
{"level":"info","ts":"2026-05-05T15:32:37.537007Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]}
{"level":"info","ts":"2026-05-05T15:32:37.539061Z","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-05-05T15:32:37.539104Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"}
{"level":"info","ts":"2026-05-05T15:32:37.539151Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"}
{"level":"info","ts":"2026-05-05T15:32:37.539395Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T15:32:37.539471Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T15:32:38.515759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T15:32:38.515831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T15:32:38.515873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"}
{"level":"info","ts":"2026-05-05T15:32:38.515897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"}
{"level":"info","ts":"2026-05-05T15:32:38.515909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"}
{"level":"info","ts":"2026-05-05T15:32:38.515925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"}
{"level":"info","ts":"2026-05-05T15:32:38.515941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"}
{"level":"info","ts":"2026-05-05T15:32:38.516999Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T15:32:38.51783Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T15:32:38.517833Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T15:32:38.517865Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T15:32:38.518147Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T15:32:38.518188Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T15:32:38.518789Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T15:32:38.519012Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T15:32:38.51908Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T15:32:38.519484Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"}
{"level":"info","ts":"2026-05-05T15:32:38.521654Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-05T15:33:23.414038Z","caller":"traceutil/trace.go:171","msg":"trace[134827461] transaction","detail":"{read_only:false; number_of_response:1; response_revision:517; }","duration":"194.638709ms","start":"2026-05-05T15:33:23.219301Z","end":"2026-05-05T15:33:23.41394Z","steps":["trace[134827461] 'process raft request'  (duration: 194.198239ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.416001Z","caller":"traceutil/trace.go:171","msg":"trace[823988012] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"194.885066ms","start":"2026-05-05T15:33:23.22109Z","end":"2026-05-05T15:33:23.415975Z","steps":["trace[823988012] 'process raft request'  (duration: 192.809307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.416274Z","caller":"traceutil/trace.go:171","msg":"trace[716063190] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"192.397367ms","start":"2026-05-05T15:33:23.223828Z","end":"2026-05-05T15:33:23.416226Z","steps":["trace[716063190] 'process raft request'  (duration: 190.225736ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.416486Z","caller":"traceutil/trace.go:171","msg":"trace[334424345] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"191.845113ms","start":"2026-05-05T15:33:23.224604Z","end":"2026-05-05T15:33:23.416449Z","steps":["trace[334424345] 'process raft request'  (duration: 190.747528ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.417036Z","caller":"traceutil/trace.go:171","msg":"trace[1655961942] transaction","detail":"{read_only:false; number_of_response:1; response_revision:517; }","duration":"196.416521ms","start":"2026-05-05T15:33:23.220071Z","end":"2026-05-05T15:33:23.416488Z","steps":["trace[1655961942] 'process raft request'  (duration: 193.602305ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.419262Z","caller":"traceutil/trace.go:171","msg":"trace[1630012415] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"194.522577ms","start":"2026-05-05T15:33:23.22471Z","end":"2026-05-05T15:33:23.419233Z","steps":["trace[1630012415] 'process raft request'  (duration: 192.618542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.419383Z","caller":"traceutil/trace.go:171","msg":"trace[1167416573] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"187.661286ms","start":"2026-05-05T15:33:23.231699Z","end":"2026-05-05T15:33:23.419361Z","steps":["trace[1167416573] 'process raft request'  (duration: 187.603344ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.419366Z","caller":"traceutil/trace.go:171","msg":"trace[745396984] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"189.493289ms","start":"2026-05-05T15:33:23.229837Z","end":"2026-05-05T15:33:23.41933Z","steps":["trace[745396984] 'process raft request'  (duration: 189.308735ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.419399Z","caller":"traceutil/trace.go:171","msg":"trace[1893592616] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"189.501389ms","start":"2026-05-05T15:33:23.229862Z","end":"2026-05-05T15:33:23.419363Z","steps":["trace[1893592616] 'process raft request'  (duration: 189.387706ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:23.422286Z","caller":"traceutil/trace.go:171","msg":"trace[866093291] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"169.279341ms","start":"2026-05-05T15:33:23.252981Z","end":"2026-05-05T15:33:23.42226Z","steps":["trace[866093291] 'process raft request'  (duration: 168.961383ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:33:29.304632Z","caller":"traceutil/trace.go:171","msg":"trace[1055502299] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"101.752509ms","start":"2026-05-05T15:33:29.202839Z","end":"2026-05-05T15:33:29.304591Z","steps":["trace[1055502299] 'process raft request'  (duration: 100.827017ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:33:29.693077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.767192ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575525412 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T15:33:29.693207Z","caller":"traceutil/trace.go:171","msg":"trace[1445635366] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"254.043561ms","start":"2026-05-05T15:33:29.439145Z","end":"2026-05-05T15:33:29.693188Z","steps":["trace[1445635366] 'read index received'  (duration: 61.627794ms)","trace[1445635366] 'applied index is now lower than readState.Index'  (duration: 192.414467ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:33:29.693265Z","caller":"traceutil/trace.go:171","msg":"trace[2089776776] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"325.135837ms","start":"2026-05-05T15:33:29.368081Z","end":"2026-05-05T15:33:29.693217Z","steps":["trace[2089776776] 'process raft request'  (duration: 132.775151ms)","trace[2089776776] 'compare'  (duration: 191.596757ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T15:33:29.693388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.210455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5xjr6\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-05T15:33:29.693424Z","caller":"traceutil/trace.go:171","msg":"trace[1789250677] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5xjr6; range_end:; response_count:1; response_revision:610; }","duration":"254.312238ms","start":"2026-05-05T15:33:29.439103Z","end":"2026-05-05T15:33:29.693415Z","steps":["trace[1789250677] 'agreement among raft nodes before linearized reading'  (duration: 254.129503ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:33:29.693447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:33:29.368044Z","time spent":"325.329812ms","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-05-05T15:33:30.180888Z","caller":"traceutil/trace.go:171","msg":"trace[1698087139] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"473.469744ms","start":"2026-05-05T15:33:29.707378Z","end":"2026-05-05T15:33:30.180848Z","steps":["trace[1698087139] 'process raft request'  (duration: 473.185318ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:33:30.181298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:33:29.707356Z","time spent":"473.619708ms","remote":"127.0.0.1:60208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-5xjr6\" mod_revision:492 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-5xjr6\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-5xjr6\" > >"}
{"level":"info","ts":"2026-05-05T15:33:30.23348Z","caller":"traceutil/trace.go:171","msg":"trace[1243146082] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"138.889674ms","start":"2026-05-05T15:33:30.094567Z","end":"2026-05-05T15:33:30.233456Z","steps":["trace[1243146082] 'process raft request'  (duration: 138.191238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:34:36.961365Z","caller":"traceutil/trace.go:171","msg":"trace[1617990060] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"105.317357ms","start":"2026-05-05T15:34:36.856021Z","end":"2026-05-05T15:34:36.961338Z","steps":["trace[1617990060] 'process raft request'  (duration: 104.635611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:01.92621Z","caller":"traceutil/trace.go:171","msg":"trace[1253024718] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"154.690694ms","start":"2026-05-05T15:35:01.77149Z","end":"2026-05-05T15:35:01.92618Z","steps":["trace[1253024718] 'read index received'  (duration: 154.568881ms)","trace[1253024718] 'applied index is now lower than readState.Index'  (duration: 120.492µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T15:35:01.926464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.96759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-05T15:35:01.926538Z","caller":"traceutil/trace.go:171","msg":"trace[805584683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1848; }","duration":"155.110453ms","start":"2026-05-05T15:35:01.771408Z","end":"2026-05-05T15:35:01.926519Z","steps":["trace[805584683] 'agreement among raft nodes before linearized reading'  (duration: 154.902869ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:02.028732Z","caller":"traceutil/trace.go:171","msg":"trace[750509978] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"101.345914ms","start":"2026-05-05T15:35:01.927351Z","end":"2026-05-05T15:35:02.028697Z","steps":["trace[750509978] 'process raft request'  (duration: 74.697131ms)","trace[750509978] 'compare'  (duration: 26.461799ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:35:02.042543Z","caller":"traceutil/trace.go:171","msg":"trace[288036795] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"112.229529ms","start":"2026-05-05T15:35:01.93029Z","end":"2026-05-05T15:35:02.042519Z","steps":["trace[288036795] 'process raft request'  (duration: 112.029735ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:02.042826Z","caller":"traceutil/trace.go:171","msg":"trace[1369364277] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"109.636728ms","start":"2026-05-05T15:35:01.93315Z","end":"2026-05-05T15:35:02.042787Z","steps":["trace[1369364277] 'process raft request'  (duration: 109.314051ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:02.36243Z","caller":"traceutil/trace.go:171","msg":"trace[1185767947] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"107.483748ms","start":"2026-05-05T15:35:02.254917Z","end":"2026-05-05T15:35:02.362401Z","steps":["trace[1185767947] 'process raft request'  (duration: 107.328654ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:18.124771Z","caller":"traceutil/trace.go:171","msg":"trace[1024118084] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"115.499826ms","start":"2026-05-05T15:35:18.009251Z","end":"2026-05-05T15:35:18.124751Z","steps":["trace[1024118084] 'process raft request'  (duration: 115.010795ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:57.592594Z","caller":"traceutil/trace.go:171","msg":"trace[1428277044] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2282; }","duration":"443.327772ms","start":"2026-05-05T15:35:57.149235Z","end":"2026-05-05T15:35:57.592563Z","steps":["trace[1428277044] 'read index received'  (duration: 93.464629ms)","trace[1428277044] 'applied index is now lower than readState.Index'  (duration: 349.861803ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:35:57.592637Z","caller":"traceutil/trace.go:171","msg":"trace[1455987436] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"443.990639ms","start":"2026-05-05T15:35:57.14861Z","end":"2026-05-05T15:35:57.592601Z","steps":["trace[1455987436] 'process raft request'  (duration: 350.322364ms)","trace[1455987436] 'compare'  (duration: 93.483661ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T15:35:57.592828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:35:57.148582Z","time spent":"444.152522ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2189 > 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\" > >"}
{"level":"warn","ts":"2026-05-05T15:35:57.592946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.696231ms","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-05-05T15:35:57.593051Z","caller":"traceutil/trace.go:171","msg":"trace[1021946778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2200; }","duration":"443.839514ms","start":"2026-05-05T15:35:57.149191Z","end":"2026-05-05T15:35:57.593031Z","steps":["trace[1021946778] 'agreement among raft nodes before linearized reading'  (duration: 443.492406ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:35:57.593091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:35:57.149181Z","time spent":"443.901696ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T15:35:57.674654Z","caller":"traceutil/trace.go:171","msg":"trace[1218242079] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"353.132869ms","start":"2026-05-05T15:35:57.321461Z","end":"2026-05-05T15:35:57.674593Z","steps":["trace[1218242079] 'process raft request'  (duration: 352.781601ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:35:57.674878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:35:57.321426Z","time spent":"353.335494ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2193 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-05T15:35:57.675224Z","caller":"traceutil/trace.go:171","msg":"trace[343353706] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"352.057483ms","start":"2026-05-05T15:35:57.323124Z","end":"2026-05-05T15:35:57.675182Z","steps":["trace[343353706] 'process raft request'  (duration: 351.305366ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:35:57.675564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:35:57.323114Z","time spent":"352.3345ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2194 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-05T15:35:57.675951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.953303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T15:35:57.676062Z","caller":"traceutil/trace.go:171","msg":"trace[311433352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2202; }","duration":"520.137227ms","start":"2026-05-05T15:35:57.1559Z","end":"2026-05-05T15:35:57.676037Z","steps":["trace[311433352] 'agreement among raft nodes before linearized reading'  (duration: 519.877031ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:35:57.67614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:35:57.155888Z","time spent":"520.229348ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-05T15:35:57.676119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.190864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-05-05T15:35:57.676171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.839296ms","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-05-05T15:35:57.676259Z","caller":"traceutil/trace.go:171","msg":"trace[1769789149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2202; }","duration":"114.989249ms","start":"2026-05-05T15:35:57.561249Z","end":"2026-05-05T15:35:57.676238Z","steps":["trace[1769789149] 'agreement among raft nodes before linearized reading'  (duration: 114.667582ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:57.676195Z","caller":"traceutil/trace.go:171","msg":"trace[1359555516] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2202; }","duration":"472.313627ms","start":"2026-05-05T15:35:57.203864Z","end":"2026-05-05T15:35:57.676178Z","steps":["trace[1359555516] 'agreement among raft nodes before linearized reading'  (duration: 472.091402ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:35:57.676372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:35:57.203846Z","time spent":"472.511941ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-05T15:35:57.833735Z","caller":"traceutil/trace.go:171","msg":"trace[488496384] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"236.195113ms","start":"2026-05-05T15:35:57.597512Z","end":"2026-05-05T15:35:57.833707Z","steps":["trace[488496384] 'process raft request'  (duration: 174.055241ms)","trace[488496384] 'compare'  (duration: 61.811545ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:35:57.833699Z","caller":"traceutil/trace.go:171","msg":"trace[1393983410] linearizableReadLoop","detail":"{readStateIndex:2286; appliedIndex:2285; }","duration":"156.440252ms","start":"2026-05-05T15:35:57.677221Z","end":"2026-05-05T15:35:57.833661Z","steps":["trace[1393983410] 'read index received'  (duration: 94.31498ms)","trace[1393983410] 'applied index is now lower than readState.Index'  (duration: 62.124312ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T15:35:57.83394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.696609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T15:35:57.834028Z","caller":"traceutil/trace.go:171","msg":"trace[1568763971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2203; }","duration":"156.820332ms","start":"2026-05-05T15:35:57.677174Z","end":"2026-05-05T15:35:57.833994Z","steps":["trace[1568763971] 'agreement among raft nodes before linearized reading'  (duration: 156.635988ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:35:57.834844Z","caller":"traceutil/trace.go:171","msg":"trace[653351329] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"155.145292ms","start":"2026-05-05T15:35:57.679689Z","end":"2026-05-05T15:35:57.834834Z","steps":["trace[653351329] 'process raft request'  (duration: 154.851065ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:39:45.985095Z","caller":"traceutil/trace.go:171","msg":"trace[811559799] transaction","detail":"{read_only:false; response_revision:3814; number_of_response:1; }","duration":"102.551954ms","start":"2026-05-05T15:39:45.882512Z","end":"2026-05-05T15:39:45.985064Z","steps":["trace[811559799] 'process raft request'  (duration: 102.336879ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:41:10.256278Z","caller":"traceutil/trace.go:171","msg":"trace[1926753413] linearizableReadLoop","detail":"{readStateIndex:5188; appliedIndex:5187; }","duration":"197.555105ms","start":"2026-05-05T15:41:10.058697Z","end":"2026-05-05T15:41:10.256252Z","steps":["trace[1926753413] 'read index received'  (duration: 197.293439ms)","trace[1926753413] 'applied index is now lower than readState.Index'  (duration: 260.486µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:41:10.256379Z","caller":"traceutil/trace.go:171","msg":"trace[499085092] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"198.429145ms","start":"2026-05-05T15:41:10.057926Z","end":"2026-05-05T15:41:10.256355Z","steps":["trace[499085092] 'process raft request'  (duration: 198.171049ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:41:10.256477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.76006ms","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-05-05T15:41:10.256514Z","caller":"traceutil/trace.go:171","msg":"trace[2134491876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5001; }","duration":"197.837812ms","start":"2026-05-05T15:41:10.058668Z","end":"2026-05-05T15:41:10.256505Z","steps":["trace[2134491876] 'agreement among raft nodes before linearized reading'  (duration: 197.689568ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:41:27.184221Z","caller":"traceutil/trace.go:171","msg":"trace[1513490168] linearizableReadLoop","detail":"{readStateIndex:5567; appliedIndex:5566; }","duration":"201.129129ms","start":"2026-05-05T15:41:26.983058Z","end":"2026-05-05T15:41:27.184188Z","steps":["trace[1513490168] 'read index received'  (duration: 201.015186ms)","trace[1513490168] 'applied index is now lower than readState.Index'  (duration: 110.553µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:41:27.184258Z","caller":"traceutil/trace.go:171","msg":"trace[782865085] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"202.852771ms","start":"2026-05-05T15:41:26.981361Z","end":"2026-05-05T15:41:27.184213Z","steps":["trace[782865085] 'process raft request'  (duration: 202.667196ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:41:27.184441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.356284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-36b1892c-34bd-458e-9b05-99ac95171502\" ","response":"range_response_count:1 size:3766"}
{"level":"info","ts":"2026-05-05T15:41:27.184483Z","caller":"traceutil/trace.go:171","msg":"trace[172772173] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-36b1892c-34bd-458e-9b05-99ac95171502; range_end:; response_count:1; response_revision:5369; }","duration":"201.414867ms","start":"2026-05-05T15:41:26.983056Z","end":"2026-05-05T15:41:27.184471Z","steps":["trace[172772173] 'agreement among raft nodes before linearized reading'  (duration: 201.268322ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:41:27.47834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.62899ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575536162 > lease_revoke:<id:59449df8c5103739>","response":"size:28"}
{"level":"warn","ts":"2026-05-05T15:41:27.478504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.709869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T15:41:27.478531Z","caller":"traceutil/trace.go:171","msg":"trace[708170891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5369; }","duration":"321.795701ms","start":"2026-05-05T15:41:27.156728Z","end":"2026-05-05T15:41:27.478524Z","steps":["trace[708170891] 'agreement among raft nodes before linearized reading'  (duration: 321.726759ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:41:27.478556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:41:27.156718Z","time spent":"321.830981ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-05T15:41:27.478429Z","caller":"traceutil/trace.go:171","msg":"trace[242413373] linearizableReadLoop","detail":"{readStateIndex:5568; appliedIndex:5567; }","duration":"294.116448ms","start":"2026-05-05T15:41:27.184299Z","end":"2026-05-05T15:41:27.478416Z","steps":["trace[242413373] 'read index received'  (duration: 27.430147ms)","trace[242413373] 'applied index is now lower than readState.Index'  (duration: 266.685231ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T15:41:27.478833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.155404ms","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-05-05T15:41:27.478855Z","caller":"traceutil/trace.go:171","msg":"trace[1682253054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5369; }","duration":"207.215745ms","start":"2026-05-05T15:41:27.271634Z","end":"2026-05-05T15:41:27.47885Z","steps":["trace[1682253054] 'agreement among raft nodes before linearized reading'  (duration: 207.129873ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:41:27.479012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.517469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T15:41:27.479069Z","caller":"traceutil/trace.go:171","msg":"trace[1044560798] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:5369; }","duration":"332.577571ms","start":"2026-05-05T15:41:27.146449Z","end":"2026-05-05T15:41:27.479027Z","steps":["trace[1044560798] 'agreement among raft nodes before linearized reading'  (duration: 332.294664ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:41:27.479094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T15:41:27.146432Z","time spent":"332.655842ms","remote":"127.0.0.1:60174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":6,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"info","ts":"2026-05-05T15:42:38.548068Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2949}
{"level":"info","ts":"2026-05-05T15:42:38.616981Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2949,"took":"67.601849ms","hash":4235922052,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":33894400,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-05T15:42:38.617088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4235922052,"revision":2949,"compact-revision":-1}
{"level":"warn","ts":"2026-05-05T15:47:33.845733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.083107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T15:47:33.845915Z","caller":"traceutil/trace.go:171","msg":"trace[697833882] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:8205; }","duration":"140.370353ms","start":"2026-05-05T15:47:33.705515Z","end":"2026-05-05T15:47:33.845885Z","steps":["trace[697833882] 'count revisions from in-memory index tree'  (duration: 139.975824ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:47:33.953999Z","caller":"traceutil/trace.go:171","msg":"trace[1369857421] transaction","detail":"{read_only:false; response_revision:8206; number_of_response:1; }","duration":"209.575076ms","start":"2026-05-05T15:47:33.744391Z","end":"2026-05-05T15:47:33.953966Z","steps":["trace[1369857421] 'process raft request'  (duration: 209.357081ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:47:33.954422Z","caller":"traceutil/trace.go:171","msg":"trace[1863434729] linearizableReadLoop","detail":"{readStateIndex:8491; appliedIndex:8489; }","duration":"138.332974ms","start":"2026-05-05T15:47:33.816066Z","end":"2026-05-05T15:47:33.954399Z","steps":["trace[1863434729] 'read index received'  (duration: 137.72871ms)","trace[1863434729] 'applied index is now lower than readState.Index'  (duration: 603.674µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:47:33.954494Z","caller":"traceutil/trace.go:171","msg":"trace[1172613989] transaction","detail":"{read_only:false; response_revision:8208; number_of_response:1; }","duration":"110.426467ms","start":"2026-05-05T15:47:33.844035Z","end":"2026-05-05T15:47:33.954461Z","steps":["trace[1172613989] 'process raft request'  (duration: 110.336465ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:47:33.954537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.457717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T15:47:33.954569Z","caller":"traceutil/trace.go:171","msg":"trace[1705667100] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:8208; }","duration":"138.556249ms","start":"2026-05-05T15:47:33.816003Z","end":"2026-05-05T15:47:33.95456Z","steps":["trace[1705667100] 'agreement among raft nodes before linearized reading'  (duration: 138.476557ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:47:33.954494Z","caller":"traceutil/trace.go:171","msg":"trace[354993503] transaction","detail":"{read_only:false; response_revision:8207; number_of_response:1; }","duration":"207.660791ms","start":"2026-05-05T15:47:33.746792Z","end":"2026-05-05T15:47:33.954453Z","steps":["trace[354993503] 'process raft request'  (duration: 207.476756ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:47:38.555622Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6039}
{"level":"info","ts":"2026-05-05T15:47:38.663274Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6039,"took":"105.564821ms","hash":2172169246,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":23269376,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-05T15:47:38.663365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2172169246,"revision":6039,"compact-revision":2949}
{"level":"info","ts":"2026-05-05T15:47:45.742217Z","caller":"traceutil/trace.go:171","msg":"trace[1755765401] transaction","detail":"{read_only:false; response_revision:8268; number_of_response:1; }","duration":"217.879215ms","start":"2026-05-05T15:47:45.524311Z","end":"2026-05-05T15:47:45.74219Z","steps":["trace[1755765401] 'process raft request'  (duration: 211.39007ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:47:45.747271Z","caller":"traceutil/trace.go:171","msg":"trace[251066930] transaction","detail":"{read_only:false; response_revision:8269; number_of_response:1; }","duration":"222.69325ms","start":"2026-05-05T15:47:45.524529Z","end":"2026-05-05T15:47:45.747222Z","steps":["trace[251066930] 'process raft request'  (duration: 222.502155ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:48:18.427506Z","caller":"traceutil/trace.go:171","msg":"trace[1112997871] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"119.784472ms","start":"2026-05-05T15:48:18.307688Z","end":"2026-05-05T15:48:18.427473Z","steps":["trace[1112997871] 'process raft request'  (duration: 105.802018ms)","trace[1112997871] 'compare'  (duration: 13.231816ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:48:18.428175Z","caller":"traceutil/trace.go:171","msg":"trace[393730262] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"120.197071ms","start":"2026-05-05T15:48:18.307959Z","end":"2026-05-05T15:48:18.428156Z","steps":["trace[393730262] 'process raft request'  (duration: 119.979006ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T15:48:28.324599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.137565ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575544698 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8569 > 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-05-05T15:48:28.324774Z","caller":"traceutil/trace.go:171","msg":"trace[1692465000] linearizableReadLoop","detail":"{readStateIndex:8893; appliedIndex:8892; }","duration":"168.622168ms","start":"2026-05-05T15:48:28.156121Z","end":"2026-05-05T15:48:28.324743Z","steps":["trace[1692465000] 'read index received'  (duration: 39.294229ms)","trace[1692465000] 'applied index is now lower than readState.Index'  (duration: 129.325799ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:48:28.324875Z","caller":"traceutil/trace.go:171","msg":"trace[354106228] transaction","detail":"{read_only:false; response_revision:8592; number_of_response:1; }","duration":"242.018762ms","start":"2026-05-05T15:48:28.082813Z","end":"2026-05-05T15:48:28.324832Z","steps":["trace[354106228] 'process raft request'  (duration: 112.521799ms)","trace[354106228] 'compare'  (duration: 128.92955ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T15:48:28.324931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.796202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T15:48:28.324993Z","caller":"traceutil/trace.go:171","msg":"trace[1407656593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8592; }","duration":"168.898275ms","start":"2026-05-05T15:48:28.156075Z","end":"2026-05-05T15:48:28.324973Z","steps":["trace[1407656593] 'agreement among raft nodes before linearized reading'  (duration: 168.786522ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:48:28.331201Z","caller":"traceutil/trace.go:171","msg":"trace[1680216895] transaction","detail":"{read_only:false; response_revision:8593; number_of_response:1; }","duration":"166.058107ms","start":"2026-05-05T15:48:28.165126Z","end":"2026-05-05T15:48:28.331184Z","steps":["trace[1680216895] 'process raft request'  (duration: 165.685428ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:48:28.331366Z","caller":"traceutil/trace.go:171","msg":"trace[417083616] transaction","detail":"{read_only:false; response_revision:8594; number_of_response:1; }","duration":"144.219405ms","start":"2026-05-05T15:48:28.187137Z","end":"2026-05-05T15:48:28.331356Z","steps":["trace[417083616] 'process raft request'  (duration: 143.787675ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:49:12.519365Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002460.wal"}
{"level":"info","ts":"2026-05-05T15:49:44.718354Z","caller":"traceutil/trace.go:171","msg":"trace[1593027991] transaction","detail":"{read_only:false; response_revision:9345; number_of_response:1; }","duration":"109.163357ms","start":"2026-05-05T15:49:44.609161Z","end":"2026-05-05T15:49:44.718324Z","steps":["trace[1593027991] 'process raft request'  (duration: 108.993463ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:50:29.322094Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T15:50:29.327003Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-05T15:50:29.327213Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-05T15:52:38.563389Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8233}
{"level":"info","ts":"2026-05-05T15:52:38.639504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8233,"took":"73.782551ms","hash":1256686831,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":25382912,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-05T15:52:38.63957Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1256686831,"revision":8233,"compact-revision":6039}
{"level":"info","ts":"2026-05-05T15:53:31.36996Z","caller":"traceutil/trace.go:171","msg":"trace[394129240] transaction","detail":"{read_only:false; response_revision:11209; number_of_response:1; }","duration":"120.967967ms","start":"2026-05-05T15:53:31.248946Z","end":"2026-05-05T15:53:31.369914Z","steps":["trace[394129240] 'process raft request'  (duration: 120.766113ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:53:31.790359Z","caller":"traceutil/trace.go:171","msg":"trace[764789340] transaction","detail":"{read_only:false; response_revision:11213; number_of_response:1; }","duration":"146.926717ms","start":"2026-05-05T15:53:31.64339Z","end":"2026-05-05T15:53:31.790317Z","steps":["trace[764789340] 'process raft request'  (duration: 103.409479ms)","trace[764789340] 'compare'  (duration: 43.358265ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T15:53:31.824248Z","caller":"traceutil/trace.go:171","msg":"trace[1562855312] transaction","detail":"{read_only:false; response_revision:11214; number_of_response:1; }","duration":"113.630033ms","start":"2026-05-05T15:53:31.710579Z","end":"2026-05-05T15:53:31.824209Z","steps":["trace[1562855312] 'process raft request'  (duration: 113.308345ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T15:57:38.569153Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10727}
{"level":"info","ts":"2026-05-05T15:57:38.653831Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10727,"took":"82.50627ms","hash":1992874389,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":27369472,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-05T15:57:38.653891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1992874389,"revision":10727,"compact-revision":8233}
{"level":"info","ts":"2026-05-05T16:02:36.40231Z","caller":"traceutil/trace.go:171","msg":"trace[454521909] transaction","detail":"{read_only:false; response_revision:14603; number_of_response:1; }","duration":"124.889967ms","start":"2026-05-05T16:02:36.277388Z","end":"2026-05-05T16:02:36.402278Z","steps":["trace[454521909] 'process raft request'  (duration: 124.702212ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:02:38.575121Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12806}
{"level":"info","ts":"2026-05-05T16:02:38.64717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12806,"took":"69.569339ms","hash":551405938,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":24854528,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-05T16:02:38.647235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":551405938,"revision":12806,"compact-revision":10727}
{"level":"info","ts":"2026-05-05T16:03:53.356811Z","caller":"traceutil/trace.go:171","msg":"trace[975549229] transaction","detail":"{read_only:false; response_revision:15010; number_of_response:1; }","duration":"170.08614ms","start":"2026-05-05T16:03:53.186701Z","end":"2026-05-05T16:03:53.356787Z","steps":["trace[975549229] 'process raft request'  (duration: 169.947317ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:04:14.977741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.061831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-428fec3d-5bce-4b06-a779-79ae446feea9\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-05-05T16:04:14.97782Z","caller":"traceutil/trace.go:171","msg":"trace[283784247] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-428fec3d-5bce-4b06-a779-79ae446feea9; range_end:; response_count:1; response_revision:15318; }","duration":"313.151913ms","start":"2026-05-05T16:04:14.664651Z","end":"2026-05-05T16:04:14.977802Z","steps":["trace[283784247] 'range keys from in-memory index tree'  (duration: 312.898017ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:04:14.97785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:04:14.664591Z","time spent":"313.253055ms","remote":"127.0.0.1:60208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3660,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-428fec3d-5bce-4b06-a779-79ae446feea9\" "}
{"level":"warn","ts":"2026-05-05T16:04:14.977823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.922847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-05T16:04:14.977904Z","caller":"traceutil/trace.go:171","msg":"trace[1736575748] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15318; }","duration":"223.0564ms","start":"2026-05-05T16:04:14.754829Z","end":"2026-05-05T16:04:14.977886Z","steps":["trace[1736575748] 'range keys from in-memory index tree'  (duration: 222.814545ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:04:14.977996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.59373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8bv7j\" ","response":"range_response_count:1 size:6451"}
{"level":"info","ts":"2026-05-05T16:04:14.978024Z","caller":"traceutil/trace.go:171","msg":"trace[37791617] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8bv7j; range_end:; response_count:1; response_revision:15318; }","duration":"157.951259ms","start":"2026-05-05T16:04:14.820066Z","end":"2026-05-05T16:04:14.978017Z","steps":["trace[37791617] 'range keys from in-memory index tree'  (duration: 157.502519ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:05:10.414524Z","caller":"traceutil/trace.go:171","msg":"trace[1314866662] transaction","detail":"{read_only:false; response_revision:15988; number_of_response:1; }","duration":"125.266165ms","start":"2026-05-05T16:05:10.289218Z","end":"2026-05-05T16:05:10.414484Z","steps":["trace[1314866662] 'process raft request'  (duration: 88.277527ms)","trace[1314866662] 'compare'  (duration: 36.605768ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:05:10.851537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.761332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-05-05T16:05:10.851644Z","caller":"traceutil/trace.go:171","msg":"trace[2101078807] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15990; }","duration":"144.895715ms","start":"2026-05-05T16:05:10.706721Z","end":"2026-05-05T16:05:10.851617Z","steps":["trace[2101078807] 'range keys from in-memory index tree'  (duration: 144.587498ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.851955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.370266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T16:05:10.852012Z","caller":"traceutil/trace.go:171","msg":"trace[1755590177] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15990; }","duration":"325.465807ms","start":"2026-05-05T16:05:10.526533Z","end":"2026-05-05T16:05:10.851999Z","steps":["trace[1755590177] 'range keys from in-memory index tree'  (duration: 325.295624ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.852177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.675315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-jg2tz\" ","response":"range_response_count:1 size:20675"}
{"level":"warn","ts":"2026-05-05T16:05:10.852221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.279713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-05-05T16:05:10.852272Z","caller":"traceutil/trace.go:171","msg":"trace[114263713] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-jg2tz; range_end:; response_count:1; response_revision:15990; }","duration":"303.795677ms","start":"2026-05-05T16:05:10.548456Z","end":"2026-05-05T16:05:10.852251Z","steps":["trace[114263713] 'range keys from in-memory index tree'  (duration: 303.47054ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:05:10.852288Z","caller":"traceutil/trace.go:171","msg":"trace[171619952] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15990; }","duration":"325.370967ms","start":"2026-05-05T16:05:10.526901Z","end":"2026-05-05T16:05:10.852272Z","steps":["trace[171619952] 'range keys from in-memory index tree'  (duration: 325.15135ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.85231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:05:10.548447Z","time spent":"303.85536ms","remote":"127.0.0.1:60208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20698,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-jg2tz\" "}
{"level":"warn","ts":"2026-05-05T16:05:10.852322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:05:10.526891Z","time spent":"325.422488ms","remote":"127.0.0.1:60184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-05-05T16:05:10.852365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.847328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-05-05T16:05:10.852439Z","caller":"traceutil/trace.go:171","msg":"trace[1703928008] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15990; }","duration":"147.96838ms","start":"2026-05-05T16:05:10.704453Z","end":"2026-05-05T16:05:10.852421Z","steps":["trace[1703928008] 'range keys from in-memory index tree'  (duration: 147.641732ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.852585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.160428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-05-05T16:05:10.852714Z","caller":"traceutil/trace.go:171","msg":"trace[1572840546] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15990; }","duration":"322.327213ms","start":"2026-05-05T16:05:10.530367Z","end":"2026-05-05T16:05:10.852695Z","steps":["trace[1572840546] 'range keys from in-memory index tree'  (duration: 321.793459ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.852852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:05:10.530357Z","time spent":"322.476336ms","remote":"127.0.0.1:60260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5471,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-05-05T16:05:10.852201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.826726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T16:05:10.853089Z","caller":"traceutil/trace.go:171","msg":"trace[531864106] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15990; }","duration":"148.723078ms","start":"2026-05-05T16:05:10.704316Z","end":"2026-05-05T16:05:10.85304Z","steps":["trace[531864106] 'range keys from in-memory index tree'  (duration: 147.746204ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.852183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.194811ms","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-05-05T16:05:10.853254Z","caller":"traceutil/trace.go:171","msg":"trace[1444710841] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15990; }","duration":"208.319458ms","start":"2026-05-05T16:05:10.644909Z","end":"2026-05-05T16:05:10.853228Z","steps":["trace[1444710841] 'count revisions from in-memory index tree'  (duration: 207.099438ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:05:10.85286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:05:10.526504Z","time spent":"326.336489ms","remote":"127.0.0.1:60260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"info","ts":"2026-05-05T16:07:38.581356Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14613}
{"level":"info","ts":"2026-05-05T16:07:38.655979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14613,"took":"71.049717ms","hash":3944719873,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":28876800,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-05T16:07:38.656036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3944719873,"revision":14613,"compact-revision":12806}
{"level":"warn","ts":"2026-05-05T16:11:16.962548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.44763ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575576073 > lease_revoke:<id:59449df8c510d4b4>","response":"size:29"}
{"level":"info","ts":"2026-05-05T16:11:23.362513Z","caller":"traceutil/trace.go:171","msg":"trace[86118678] transaction","detail":"{read_only:false; response_revision:18713; number_of_response:1; }","duration":"108.766021ms","start":"2026-05-05T16:11:23.25371Z","end":"2026-05-05T16:11:23.362476Z","steps":["trace[86118678] 'process raft request'  (duration: 108.541476ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:11:23.58866Z","caller":"traceutil/trace.go:171","msg":"trace[1266681334] linearizableReadLoop","detail":"{readStateIndex:19350; appliedIndex:19349; }","duration":"156.177472ms","start":"2026-05-05T16:11:23.432456Z","end":"2026-05-05T16:11:23.588634Z","steps":["trace[1266681334] 'read index received'  (duration: 156.028458ms)","trace[1266681334] 'applied index is now lower than readState.Index'  (duration: 148.014µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:11:23.588846Z","caller":"traceutil/trace.go:171","msg":"trace[1732290866] transaction","detail":"{read_only:false; response_revision:18714; number_of_response:1; }","duration":"210.836093ms","start":"2026-05-05T16:11:23.377994Z","end":"2026-05-05T16:11:23.58883Z","steps":["trace[1732290866] 'process raft request'  (duration: 210.505775ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:11:23.589337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.819237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18812"}
{"level":"info","ts":"2026-05-05T16:11:23.589467Z","caller":"traceutil/trace.go:171","msg":"trace[1498399583] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18714; }","duration":"157.009302ms","start":"2026-05-05T16:11:23.432431Z","end":"2026-05-05T16:11:23.58944Z","steps":["trace[1498399583] 'agreement among raft nodes before linearized reading'  (duration: 156.56544ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:12:14.386515Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T16:12:14.391967Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-05T16:12:14.392047Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-05T16:12:38.588333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16971}
{"level":"info","ts":"2026-05-05T16:12:38.67872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16971,"took":"87.305237ms","hash":1659176397,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":33800192,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-05T16:12:38.678778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1659176397,"revision":16971,"compact-revision":14613}
{"level":"info","ts":"2026-05-05T16:17:01.027844Z","caller":"traceutil/trace.go:171","msg":"trace[1069346082] transaction","detail":"{read_only:false; response_revision:21349; number_of_response:1; }","duration":"106.681442ms","start":"2026-05-05T16:17:00.921141Z","end":"2026-05-05T16:17:01.027822Z","steps":["trace[1069346082] 'process raft request'  (duration: 106.528138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:17:01.178595Z","caller":"traceutil/trace.go:171","msg":"trace[839565957] transaction","detail":"{read_only:false; response_revision:21350; number_of_response:1; }","duration":"255.709792ms","start":"2026-05-05T16:17:00.922859Z","end":"2026-05-05T16:17:01.178569Z","steps":["trace[839565957] 'process raft request'  (duration: 246.191393ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:17:01.178705Z","caller":"traceutil/trace.go:171","msg":"trace[843169022] linearizableReadLoop","detail":"{readStateIndex:22072; appliedIndex:22069; }","duration":"151.773175ms","start":"2026-05-05T16:17:01.026904Z","end":"2026-05-05T16:17:01.178678Z","steps":["trace[843169022] 'read index received'  (duration: 767.028µs)","trace[843169022] 'applied index is now lower than readState.Index'  (duration: 151.004957ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:17:01.178828Z","caller":"traceutil/trace.go:171","msg":"trace[398853449] transaction","detail":"{read_only:false; response_revision:21351; number_of_response:1; }","duration":"233.917209ms","start":"2026-05-05T16:17:00.944902Z","end":"2026-05-05T16:17:01.178819Z","steps":["trace[398853449] 'process raft request'  (duration: 233.630942ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:01.179042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.122384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-05T16:17:01.179082Z","caller":"traceutil/trace.go:171","msg":"trace[157549739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21351; }","duration":"152.214216ms","start":"2026-05-05T16:17:01.026857Z","end":"2026-05-05T16:17:01.179072Z","steps":["trace[157549739] 'agreement among raft nodes before linearized reading'  (duration: 152.065662ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:17:06.675328Z","caller":"traceutil/trace.go:171","msg":"trace[1567794378] transaction","detail":"{read_only:false; response_revision:21379; number_of_response:1; }","duration":"283.928859ms","start":"2026-05-05T16:17:06.391369Z","end":"2026-05-05T16:17:06.675298Z","steps":["trace[1567794378] 'process raft request'  (duration: 283.765576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.395912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.874796ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575583702 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21371 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:17:07.396166Z","caller":"traceutil/trace.go:171","msg":"trace[18903324] linearizableReadLoop","detail":"{readStateIndex:22105; appliedIndex:22103; }","duration":"189.301006ms","start":"2026-05-05T16:17:07.206847Z","end":"2026-05-05T16:17:07.396148Z","steps":["trace[18903324] 'read index received'  (duration: 10.079151ms)","trace[18903324] 'applied index is now lower than readState.Index'  (duration: 179.220875ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:17:07.396314Z","caller":"traceutil/trace.go:171","msg":"trace[171084488] transaction","detail":"{read_only:false; response_revision:21383; number_of_response:1; }","duration":"198.652341ms","start":"2026-05-05T16:17:07.197648Z","end":"2026-05-05T16:17:07.3963Z","steps":["trace[171084488] 'process raft request'  (duration: 198.422886ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:17:07.39639Z","caller":"traceutil/trace.go:171","msg":"trace[951911070] transaction","detail":"{read_only:false; response_revision:21382; number_of_response:1; }","duration":"200.120836ms","start":"2026-05-05T16:17:07.196249Z","end":"2026-05-05T16:17:07.39637Z","steps":["trace[951911070] 'process raft request'  (duration: 20.666176ms)","trace[951911070] 'compare'  (duration: 178.62596ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:17:07.396635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.766108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-05T16:17:07.396717Z","caller":"traceutil/trace.go:171","msg":"trace[1834659755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21383; }","duration":"189.899291ms","start":"2026-05-05T16:17:07.206799Z","end":"2026-05-05T16:17:07.396698Z","steps":["trace[1834659755] 'agreement among raft nodes before linearized reading'  (duration: 189.660205ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.704885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.22853ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575583704 > lease_revoke:<id:59449df8c510f306>","response":"size:29"}
{"level":"info","ts":"2026-05-05T16:17:07.704991Z","caller":"traceutil/trace.go:171","msg":"trace[703638330] linearizableReadLoop","detail":"{readStateIndex:22106; appliedIndex:22105; }","duration":"308.769577ms","start":"2026-05-05T16:17:07.396205Z","end":"2026-05-05T16:17:07.704974Z","steps":["trace[703638330] 'read index received'  (duration: 33.365991ms)","trace[703638330] 'applied index is now lower than readState.Index'  (duration: 275.402076ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:17:07.705794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.607137ms","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-05-05T16:17:07.705873Z","caller":"traceutil/trace.go:171","msg":"trace[810638837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21383; }","duration":"461.7255ms","start":"2026-05-05T16:17:07.244129Z","end":"2026-05-05T16:17:07.705855Z","steps":["trace[810638837] 'agreement among raft nodes before linearized reading'  (duration: 461.469364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.705865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.794748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-05T16:17:07.705912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:17:07.244118Z","time spent":"461.785492ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-05T16:17:07.705954Z","caller":"traceutil/trace.go:171","msg":"trace[1176895229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21383; }","duration":"495.941932ms","start":"2026-05-05T16:17:07.209991Z","end":"2026-05-05T16:17:07.705933Z","steps":["trace[1176895229] 'agreement among raft nodes before linearized reading'  (duration: 495.655725ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.705995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:17:07.209962Z","time spent":"496.025214ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-05T16:17:07.715199Z","caller":"traceutil/trace.go:171","msg":"trace[1851834372] transaction","detail":"{read_only:false; response_revision:21384; number_of_response:1; }","duration":"314.989635ms","start":"2026-05-05T16:17:07.400193Z","end":"2026-05-05T16:17:07.715182Z","steps":["trace[1851834372] 'process raft request'  (duration: 314.878653ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.715312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:17:07.400178Z","time spent":"315.070007ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:21373 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-05T16:17:07.755212Z","caller":"traceutil/trace.go:171","msg":"trace[1591638524] transaction","detail":"{read_only:false; response_revision:21385; number_of_response:1; }","duration":"248.026647ms","start":"2026-05-05T16:17:07.507152Z","end":"2026-05-05T16:17:07.755178Z","steps":["trace[1591638524] 'process raft request'  (duration: 247.784601ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.755615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.662342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"}
{"level":"info","ts":"2026-05-05T16:17:07.755712Z","caller":"traceutil/trace.go:171","msg":"trace[610438659] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:21387; }","duration":"355.777765ms","start":"2026-05-05T16:17:07.399911Z","end":"2026-05-05T16:17:07.755688Z","steps":["trace[610438659] 'agreement among raft nodes before linearized reading'  (duration: 355.496038ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.755741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.666651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-05-05T16:17:07.755771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:17:07.399891Z","time spent":"355.864328ms","remote":"127.0.0.1:60174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"info","ts":"2026-05-05T16:17:07.755832Z","caller":"traceutil/trace.go:171","msg":"trace[1273208696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21387; }","duration":"327.818674ms","start":"2026-05-05T16:17:07.427993Z","end":"2026-05-05T16:17:07.755812Z","steps":["trace[1273208696] 'agreement among raft nodes before linearized reading'  (duration: 327.571618ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.755871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:17:07.42797Z","time spent":"327.890935ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-05T16:17:07.869195Z","caller":"traceutil/trace.go:171","msg":"trace[792735597] linearizableReadLoop","detail":"{readStateIndex:22111; appliedIndex:22110; }","duration":"109.644433ms","start":"2026-05-05T16:17:07.759529Z","end":"2026-05-05T16:17:07.869174Z","steps":["trace[792735597] 'read index received'  (duration: 107.991704ms)","trace[792735597] 'applied index is now lower than readState.Index'  (duration: 1.651699ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:17:07.869454Z","caller":"traceutil/trace.go:171","msg":"trace[236900645] transaction","detail":"{read_only:false; response_revision:21388; number_of_response:1; }","duration":"110.237587ms","start":"2026-05-05T16:17:07.759186Z","end":"2026-05-05T16:17:07.869424Z","steps":["trace[236900645] 'process raft request'  (duration: 108.412594ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:07.869654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.109644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-abe54c1c-7c72-4a95-9ddf-2afcdd9cc11e\" ","response":"range_response_count:1 size:1451"}
{"level":"info","ts":"2026-05-05T16:17:07.86971Z","caller":"traceutil/trace.go:171","msg":"trace[1689332684] range","detail":"{range_begin:/registry/persistentvolumes/pvc-abe54c1c-7c72-4a95-9ddf-2afcdd9cc11e; range_end:; response_count:1; response_revision:21388; }","duration":"110.201836ms","start":"2026-05-05T16:17:07.75949Z","end":"2026-05-05T16:17:07.869692Z","steps":["trace[1689332684] 'agreement among raft nodes before linearized reading'  (duration: 109.769836ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:17:08.156459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.834954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:17:08.156546Z","caller":"traceutil/trace.go:171","msg":"trace[110867236] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:21388; }","duration":"155.994797ms","start":"2026-05-05T16:17:08.000533Z","end":"2026-05-05T16:17:08.156528Z","steps":["trace[110867236] 'count revisions from in-memory index tree'  (duration: 155.72767ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:17:38.601714Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19553}
{"level":"info","ts":"2026-05-05T16:17:38.708887Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19553,"took":"104.868679ms","hash":361418886,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":29782016,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-05T16:17:38.708947Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":361418886,"revision":19553,"compact-revision":16971}
{"level":"info","ts":"2026-05-05T16:20:52.535663Z","caller":"traceutil/trace.go:171","msg":"trace[385907213] transaction","detail":"{read_only:false; response_revision:23791; number_of_response:1; }","duration":"126.429337ms","start":"2026-05-05T16:20:52.409208Z","end":"2026-05-05T16:20:52.535638Z","steps":["trace[385907213] 'process raft request'  (duration: 108.723221ms)","trace[385907213] 'compare'  (duration: 17.257346ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:22:38.607822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21781}
{"level":"info","ts":"2026-05-05T16:22:38.710722Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21781,"took":"98.866346ms","hash":628738625,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":42229760,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-05T16:22:38.710785Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":628738625,"revision":21781,"compact-revision":19553}
{"level":"info","ts":"2026-05-05T16:24:16.46192Z","caller":"traceutil/trace.go:171","msg":"trace[94087282] transaction","detail":"{read_only:false; response_revision:25831; number_of_response:1; }","duration":"114.620673ms","start":"2026-05-05T16:24:16.347276Z","end":"2026-05-05T16:24:16.461897Z","steps":["trace[94087282] 'process raft request'  (duration: 114.186193ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:26.86154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.036732ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595725 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25894 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:26.861652Z","caller":"traceutil/trace.go:171","msg":"trace[922825840] transaction","detail":"{read_only:false; response_revision:25913; number_of_response:1; }","duration":"366.841083ms","start":"2026-05-05T16:24:26.494795Z","end":"2026-05-05T16:24:26.861636Z","steps":["trace[922825840] 'process raft request'  (duration: 229.593356ms)","trace[922825840] 'compare'  (duration: 136.607042ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:26.861695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:26.49477Z","time spent":"366.904104ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25894 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-05T16:24:27.032961Z","caller":"traceutil/trace.go:171","msg":"trace[2118269629] transaction","detail":"{read_only:false; response_revision:25914; number_of_response:1; }","duration":"393.531543ms","start":"2026-05-05T16:24:26.639403Z","end":"2026-05-05T16:24:27.032935Z","steps":["trace[2118269629] 'process raft request'  (duration: 328.46013ms)","trace[2118269629] 'compare'  (duration: 64.735595ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:27.033018Z","caller":"traceutil/trace.go:171","msg":"trace[418572469] linearizableReadLoop","detail":"{readStateIndex:26760; appliedIndex:26759; }","duration":"209.927143ms","start":"2026-05-05T16:24:26.823067Z","end":"2026-05-05T16:24:27.032994Z","steps":["trace[418572469] 'read index received'  (duration: 144.809669ms)","trace[418572469] 'applied index is now lower than readState.Index'  (duration: 65.115624ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:27.033109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:26.639377Z","time spent":"393.651277ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25895 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:27.033154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.090497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-05T16:24:27.033181Z","caller":"traceutil/trace.go:171","msg":"trace[2124055105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25915; }","duration":"210.154779ms","start":"2026-05-05T16:24:26.823019Z","end":"2026-05-05T16:24:27.033174Z","steps":["trace[2124055105] 'agreement among raft nodes before linearized reading'  (duration: 210.039726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:27.161944Z","caller":"traceutil/trace.go:171","msg":"trace[680948331] transaction","detail":"{read_only:false; response_revision:25916; number_of_response:1; }","duration":"137.075573ms","start":"2026-05-05T16:24:27.024835Z","end":"2026-05-05T16:24:27.16191Z","steps":["trace[680948331] 'process raft request'  (duration: 124.0145ms)","trace[680948331] 'compare'  (duration: 12.822417ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:27.16199Z","caller":"traceutil/trace.go:171","msg":"trace[779096114] transaction","detail":"{read_only:false; response_revision:25917; number_of_response:1; }","duration":"124.873639ms","start":"2026-05-05T16:24:27.037101Z","end":"2026-05-05T16:24:27.161975Z","steps":["trace[779096114] 'process raft request'  (duration: 124.693155ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:27.569367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.63485ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595733 > lease_revoke:<id:59449df8c5112155>","response":"size:29"}
{"level":"info","ts":"2026-05-05T16:24:27.569697Z","caller":"traceutil/trace.go:171","msg":"trace[1672141729] linearizableReadLoop","detail":"{readStateIndex:26764; appliedIndex:26763; }","duration":"260.210671ms","start":"2026-05-05T16:24:27.309459Z","end":"2026-05-05T16:24:27.56967Z","steps":["trace[1672141729] 'read index received'  (duration: 24.198502ms)","trace[1672141729] 'applied index is now lower than readState.Index'  (duration: 236.010509ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:27.57016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.682553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-d5b4d5d47-fbv7l.18acb638c47dd35d\" ","response":"range_response_count:1 size:2105"}
{"level":"info","ts":"2026-05-05T16:24:27.570252Z","caller":"traceutil/trace.go:171","msg":"trace[500189279] range","detail":"{range_begin:/registry/events/openstack/glance-api-d5b4d5d47-fbv7l.18acb638c47dd35d; range_end:; response_count:1; response_revision:25917; }","duration":"260.828076ms","start":"2026-05-05T16:24:27.309407Z","end":"2026-05-05T16:24:27.570235Z","steps":["trace[500189279] 'agreement among raft nodes before linearized reading'  (duration: 260.548249ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:27.570273Z","caller":"traceutil/trace.go:171","msg":"trace[1136395515] transaction","detail":"{read_only:false; response_revision:25918; number_of_response:1; }","duration":"178.257553ms","start":"2026-05-05T16:24:27.391983Z","end":"2026-05-05T16:24:27.570241Z","steps":["trace[1136395515] 'process raft request'  (duration: 177.527055ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:27.756435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.266461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:27.756534Z","caller":"traceutil/trace.go:171","msg":"trace[1012719244] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25918; }","duration":"386.432464ms","start":"2026-05-05T16:24:27.370075Z","end":"2026-05-05T16:24:27.756507Z","steps":["trace[1012719244] 'agreement among raft nodes before linearized reading'  (duration: 200.190909ms)","trace[1012719244] 'count revisions from in-memory index tree'  (duration: 186.090521ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:27.756586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:27.370055Z","time spent":"386.519876ms","remote":"127.0.0.1:59744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T16:24:27.756707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.998736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-05T16:24:27.756818Z","caller":"traceutil/trace.go:171","msg":"trace[256864028] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25918; }","duration":"414.15409ms","start":"2026-05-05T16:24:27.34264Z","end":"2026-05-05T16:24:27.756794Z","steps":["trace[256864028] 'agreement among raft nodes before linearized reading'  (duration: 227.601828ms)","trace[256864028] 'count revisions from in-memory index tree'  (duration: 186.403389ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:27.756868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:27.342618Z","time spent":"414.239252ms","remote":"127.0.0.1:53000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":31,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "}
{"level":"info","ts":"2026-05-05T16:24:27.791854Z","caller":"traceutil/trace.go:171","msg":"trace[738526423] transaction","detail":"{read_only:false; response_revision:25919; number_of_response:1; }","duration":"219.258127ms","start":"2026-05-05T16:24:27.572575Z","end":"2026-05-05T16:24:27.791833Z","steps":["trace[738526423] 'process raft request'  (duration: 219.072683ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.169034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.614127ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595738 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25880 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:28.169267Z","caller":"traceutil/trace.go:171","msg":"trace[1652206364] linearizableReadLoop","detail":"{readStateIndex:26767; appliedIndex:26765; }","duration":"555.308591ms","start":"2026-05-05T16:24:27.613939Z","end":"2026-05-05T16:24:28.169248Z","steps":["trace[1652206364] 'read index received'  (duration: 177.710109ms)","trace[1652206364] 'applied index is now lower than readState.Index'  (duration: 377.594511ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:28.169328Z","caller":"traceutil/trace.go:171","msg":"trace[1050403972] transaction","detail":"{read_only:false; response_revision:25921; number_of_response:1; }","duration":"327.058197ms","start":"2026-05-05T16:24:27.842222Z","end":"2026-05-05T16:24:28.16928Z","steps":["trace[1050403972] 'process raft request'  (duration: 326.965455ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.169405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.447054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:28.169441Z","caller":"traceutil/trace.go:171","msg":"trace[1391236035] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25921; }","duration":"555.524976ms","start":"2026-05-05T16:24:27.613905Z","end":"2026-05-05T16:24:28.16943Z","steps":["trace[1391236035] 'agreement among raft nodes before linearized reading'  (duration: 555.443964ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.169444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:27.842198Z","time spent":"327.192331ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25906 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:28.16947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:27.613886Z","time spent":"555.577387ms","remote":"127.0.0.1:34124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "}
{"level":"info","ts":"2026-05-05T16:24:28.169208Z","caller":"traceutil/trace.go:171","msg":"trace[329172896] transaction","detail":"{read_only:false; response_revision:25920; number_of_response:1; }","duration":"588.501948ms","start":"2026-05-05T16:24:27.580673Z","end":"2026-05-05T16:24:28.169175Z","steps":["trace[329172896] 'process raft request'  (duration: 318.639085ms)","trace[329172896] 'compare'  (duration: 269.424682ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:28.169748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:27.580648Z","time spent":"588.955669ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25880 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-05T16:24:28.185223Z","caller":"traceutil/trace.go:171","msg":"trace[1723253594] transaction","detail":"{read_only:false; response_revision:25922; number_of_response:1; }","duration":"233.108081ms","start":"2026-05-05T16:24:27.952096Z","end":"2026-05-05T16:24:28.185204Z","steps":["trace[1723253594] 'process raft request'  (duration: 233.003359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:28.197776Z","caller":"traceutil/trace.go:171","msg":"trace[1633828739] transaction","detail":"{read_only:false; response_revision:25923; number_of_response:1; }","duration":"157.677668ms","start":"2026-05-05T16:24:28.040065Z","end":"2026-05-05T16:24:28.197742Z","steps":["trace[1633828739] 'process raft request'  (duration: 157.370971ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.197845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.300204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-05-05T16:24:28.197884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.442246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-05T16:24:28.197925Z","caller":"traceutil/trace.go:171","msg":"trace[1549008482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25923; }","duration":"342.412036ms","start":"2026-05-05T16:24:27.855494Z","end":"2026-05-05T16:24:28.197906Z","steps":["trace[1549008482] 'agreement among raft nodes before linearized reading'  (duration: 342.16488ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:28.197955Z","caller":"traceutil/trace.go:171","msg":"trace[1304517411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25923; }","duration":"148.56445ms","start":"2026-05-05T16:24:28.049367Z","end":"2026-05-05T16:24:28.197931Z","steps":["trace[1304517411] 'agreement among raft nodes before linearized reading'  (duration: 148.333084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.197975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:27.855486Z","time spent":"342.479297ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-05T16:24:28.197982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.757944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-05T16:24:28.19803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.030958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-05T16:24:28.198069Z","caller":"traceutil/trace.go:171","msg":"trace[936583323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25923; }","duration":"153.884647ms","start":"2026-05-05T16:24:28.044167Z","end":"2026-05-05T16:24:28.198051Z","steps":["trace[936583323] 'agreement among raft nodes before linearized reading'  (duration: 153.5925ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:28.19808Z","caller":"traceutil/trace.go:171","msg":"trace[1858055604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25923; }","duration":"218.131131ms","start":"2026-05-05T16:24:27.979935Z","end":"2026-05-05T16:24:28.198066Z","steps":["trace[1858055604] 'agreement among raft nodes before linearized reading'  (duration: 217.949056ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.487703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.657075ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595747 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25911 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:28.487905Z","caller":"traceutil/trace.go:171","msg":"trace[176391181] transaction","detail":"{read_only:false; response_revision:25927; number_of_response:1; }","duration":"284.714431ms","start":"2026-05-05T16:24:28.203171Z","end":"2026-05-05T16:24:28.487885Z","steps":["trace[176391181] 'process raft request'  (duration: 284.653389ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:28.487968Z","caller":"traceutil/trace.go:171","msg":"trace[673185804] transaction","detail":"{read_only:false; response_revision:25926; number_of_response:1; }","duration":"284.770142ms","start":"2026-05-05T16:24:28.203158Z","end":"2026-05-05T16:24:28.487928Z","steps":["trace[673185804] 'process raft request'  (duration: 179.81353ms)","trace[673185804] 'compare'  (duration: 104.483889ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:28.777615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.245432ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595749 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25912 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:28.777876Z","caller":"traceutil/trace.go:171","msg":"trace[52805293] transaction","detail":"{read_only:false; response_revision:25929; number_of_response:1; }","duration":"146.837917ms","start":"2026-05-05T16:24:28.630997Z","end":"2026-05-05T16:24:28.777835Z","steps":["trace[52805293] 'process raft request'  (duration: 146.745445ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:28.777871Z","caller":"traceutil/trace.go:171","msg":"trace[1906750635] linearizableReadLoop","detail":"{readStateIndex:26775; appliedIndex:26774; }","duration":"206.972102ms","start":"2026-05-05T16:24:28.570869Z","end":"2026-05-05T16:24:28.777841Z","steps":["trace[1906750635] 'read index received'  (duration: 68.377023ms)","trace[1906750635] 'applied index is now lower than readState.Index'  (duration: 138.591339ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:28.778097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.215669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-05T16:24:28.778758Z","caller":"traceutil/trace.go:171","msg":"trace[1223641732] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25929; }","duration":"207.917934ms","start":"2026-05-05T16:24:28.570819Z","end":"2026-05-05T16:24:28.778737Z","steps":["trace[1223641732] 'agreement among raft nodes before linearized reading'  (duration: 207.110925ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:28.778786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.672344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-05T16:24:28.778809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.684194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:28.777871Z","caller":"traceutil/trace.go:171","msg":"trace[84992691] transaction","detail":"{read_only:false; response_revision:25928; number_of_response:1; }","duration":"271.610925ms","start":"2026-05-05T16:24:28.506215Z","end":"2026-05-05T16:24:28.777826Z","steps":["trace[84992691] 'process raft request'  (duration: 133.017766ms)","trace[84992691] 'compare'  (duration: 138.063656ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:28.778844Z","caller":"traceutil/trace.go:171","msg":"trace[529387490] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:25929; }","duration":"171.746576ms","start":"2026-05-05T16:24:28.607082Z","end":"2026-05-05T16:24:28.778829Z","steps":["trace[529387490] 'agreement among raft nodes before linearized reading'  (duration: 171.636683ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:28.77886Z","caller":"traceutil/trace.go:171","msg":"trace[697939251] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25929; }","duration":"136.774846ms","start":"2026-05-05T16:24:28.642069Z","end":"2026-05-05T16:24:28.778844Z","steps":["trace[697939251] 'agreement among raft nodes before linearized reading'  (duration: 136.686453ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:29.069264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.677726ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595763 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25913 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:29.069444Z","caller":"traceutil/trace.go:171","msg":"trace[1587642326] transaction","detail":"{read_only:false; response_revision:25930; number_of_response:1; }","duration":"204.600236ms","start":"2026-05-05T16:24:28.864823Z","end":"2026-05-05T16:24:29.069423Z","steps":["trace[1587642326] 'process raft request'  (duration: 69.675664ms)","trace[1587642326] 'compare'  (duration: 134.558203ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:29.454415Z","caller":"traceutil/trace.go:171","msg":"trace[544072682] transaction","detail":"{read_only:false; response_revision:25933; number_of_response:1; }","duration":"287.268681ms","start":"2026-05-05T16:24:29.167055Z","end":"2026-05-05T16:24:29.454324Z","steps":["trace[544072682] 'process raft request'  (duration: 287.089817ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:29.471609Z","caller":"traceutil/trace.go:171","msg":"trace[683347596] transaction","detail":"{read_only:false; response_revision:25934; number_of_response:1; }","duration":"302.664601ms","start":"2026-05-05T16:24:29.168905Z","end":"2026-05-05T16:24:29.47157Z","steps":["trace[683347596] 'process raft request'  (duration: 301.107173ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:29.471908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:29.168888Z","time spent":"302.813244ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25917 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:29.912888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.3768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:29.912979Z","caller":"traceutil/trace.go:171","msg":"trace[363803362] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25935; }","duration":"152.482113ms","start":"2026-05-05T16:24:29.760472Z","end":"2026-05-05T16:24:29.912954Z","steps":["trace[363803362] 'count revisions from in-memory index tree'  (duration: 152.263457ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:30.56896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.789628ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595781 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25924 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:30.569164Z","caller":"traceutil/trace.go:171","msg":"trace[1625028474] transaction","detail":"{read_only:false; response_revision:25939; number_of_response:1; }","duration":"329.375443ms","start":"2026-05-05T16:24:30.239762Z","end":"2026-05-05T16:24:30.569138Z","steps":["trace[1625028474] 'process raft request'  (duration: 164.304948ms)","trace[1625028474] 'compare'  (duration: 164.641504ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:30.56925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:30.239741Z","time spent":"329.469835ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25924 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-05T16:24:30.952805Z","caller":"traceutil/trace.go:171","msg":"trace[177114061] transaction","detail":"{read_only:false; response_revision:25942; number_of_response:1; }","duration":"168.384896ms","start":"2026-05-05T16:24:30.784395Z","end":"2026-05-05T16:24:30.95278Z","steps":["trace[177114061] 'process raft request'  (duration: 168.195421ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:31.230717Z","caller":"traceutil/trace.go:171","msg":"trace[2140634505] transaction","detail":"{read_only:false; response_revision:25944; number_of_response:1; }","duration":"153.255642ms","start":"2026-05-05T16:24:31.077428Z","end":"2026-05-05T16:24:31.230683Z","steps":["trace[2140634505] 'process raft request'  (duration: 152.949495ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:31.23074Z","caller":"traceutil/trace.go:171","msg":"trace[1116958501] transaction","detail":"{read_only:false; response_revision:25945; number_of_response:1; }","duration":"144.873091ms","start":"2026-05-05T16:24:31.085829Z","end":"2026-05-05T16:24:31.230702Z","steps":["trace[1116958501] 'process raft request'  (duration: 144.753278ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:31.994149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.762111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-05T16:24:31.994231Z","caller":"traceutil/trace.go:171","msg":"trace[1639766910] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:25948; }","duration":"155.901064ms","start":"2026-05-05T16:24:31.838311Z","end":"2026-05-05T16:24:31.994212Z","steps":["trace[1639766910] 'range keys from in-memory index tree'  (duration: 155.572087ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:32.397592Z","caller":"traceutil/trace.go:171","msg":"trace[1045132647] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"260.410496ms","start":"2026-05-05T16:24:32.137157Z","end":"2026-05-05T16:24:32.397568Z","steps":["trace[1045132647] 'process raft request'  (duration: 260.233142ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:32.604259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.675842ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595801 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25936 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:32.60444Z","caller":"traceutil/trace.go:171","msg":"trace[746771252] linearizableReadLoop","detail":"{readStateIndex:26799; appliedIndex:26797; }","duration":"307.689213ms","start":"2026-05-05T16:24:32.296737Z","end":"2026-05-05T16:24:32.604426Z","steps":["trace[746771252] 'read index received'  (duration: 101.258023ms)","trace[746771252] 'applied index is now lower than readState.Index'  (duration: 206.43003ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:32.604517Z","caller":"traceutil/trace.go:171","msg":"trace[1077321867] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"364.033936ms","start":"2026-05-05T16:24:32.240475Z","end":"2026-05-05T16:24:32.604509Z","steps":["trace[1077321867] 'process raft request'  (duration: 230.026816ms)","trace[1077321867] 'compare'  (duration: 133.218371ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:32.604565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.240454Z","time spent":"364.087697ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25936 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:32.604655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.901148ms","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-05-05T16:24:32.604726Z","caller":"traceutil/trace.go:171","msg":"trace[1455274321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25951; }","duration":"308.00803ms","start":"2026-05-05T16:24:32.296695Z","end":"2026-05-05T16:24:32.604703Z","steps":["trace[1455274321] 'agreement among raft nodes before linearized reading'  (duration: 307.833866ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:32.604719Z","caller":"traceutil/trace.go:171","msg":"trace[791130636] transaction","detail":"{read_only:false; response_revision:25951; number_of_response:1; }","duration":"363.321908ms","start":"2026-05-05T16:24:32.241367Z","end":"2026-05-05T16:24:32.604689Z","steps":["trace[791130636] 'process raft request'  (duration: 362.97133ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:32.60477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.296676Z","time spent":"308.086692ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-05T16:24:32.604728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.893819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"}
{"level":"info","ts":"2026-05-05T16:24:32.604835Z","caller":"traceutil/trace.go:171","msg":"trace[658147614] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25951; }","duration":"204.038872ms","start":"2026-05-05T16:24:32.400789Z","end":"2026-05-05T16:24:32.604828Z","steps":["trace[658147614] 'agreement among raft nodes before linearized reading'  (duration: 203.866568ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:32.604854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.24136Z","time spent":"363.42025ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25937 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:504 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-05T16:24:32.886107Z","caller":"traceutil/trace.go:171","msg":"trace[334711937] linearizableReadLoop","detail":"{readStateIndex:26800; appliedIndex:26799; }","duration":"277.351203ms","start":"2026-05-05T16:24:32.608726Z","end":"2026-05-05T16:24:32.886077Z","steps":["trace[334711937] 'read index received'  (duration: 270.378105ms)","trace[334711937] 'applied index is now lower than readState.Index'  (duration: 6.971778ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:32.886162Z","caller":"traceutil/trace.go:171","msg":"trace[1167056742] transaction","detail":"{read_only:false; response_revision:25952; number_of_response:1; }","duration":"277.494396ms","start":"2026-05-05T16:24:32.608628Z","end":"2026-05-05T16:24:32.886122Z","steps":["trace[1167056742] 'process raft request'  (duration: 270.462737ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:32.886414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.664581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-05T16:24:32.886492Z","caller":"traceutil/trace.go:171","msg":"trace[775880666] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:25952; }","duration":"277.755433ms","start":"2026-05-05T16:24:32.608717Z","end":"2026-05-05T16:24:32.886472Z","steps":["trace[775880666] 'agreement among raft nodes before linearized reading'  (duration: 277.471896ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:33.099364Z","caller":"traceutil/trace.go:171","msg":"trace[833316172] transaction","detail":"{read_only:false; response_revision:25954; number_of_response:1; }","duration":"490.515494ms","start":"2026-05-05T16:24:32.60883Z","end":"2026-05-05T16:24:33.099346Z","steps":["trace[833316172] 'process raft request'  (duration: 490.454802ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.099484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.608809Z","time spent":"490.612396ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25938 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-05T16:24:33.099567Z","caller":"traceutil/trace.go:171","msg":"trace[1306334255] transaction","detail":"{read_only:false; response_revision:25953; number_of_response:1; }","duration":"490.803781ms","start":"2026-05-05T16:24:32.608756Z","end":"2026-05-05T16:24:33.09956Z","steps":["trace[1306334255] 'process raft request'  (duration: 490.386701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.099596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.608753Z","time spent":"490.826341ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25940 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-05T16:24:33.099654Z","caller":"traceutil/trace.go:171","msg":"trace[756729043] linearizableReadLoop","detail":"{readStateIndex:26803; appliedIndex:26800; }","duration":"213.477589ms","start":"2026-05-05T16:24:32.88617Z","end":"2026-05-05T16:24:33.099648Z","steps":["trace[756729043] 'read index received'  (duration: 213.067269ms)","trace[756729043] 'applied index is now lower than readState.Index'  (duration: 409.55µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:33.099792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.874726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:33.09986Z","caller":"traceutil/trace.go:171","msg":"trace[473535759] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25955; }","duration":"369.985488ms","start":"2026-05-05T16:24:32.729856Z","end":"2026-05-05T16:24:33.099841Z","steps":["trace[473535759] 'agreement among raft nodes before linearized reading'  (duration: 369.869836ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.099915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.729837Z","time spent":"370.05622ms","remote":"127.0.0.1:59742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"info","ts":"2026-05-05T16:24:33.099931Z","caller":"traceutil/trace.go:171","msg":"trace[1964452350] transaction","detail":"{read_only:false; response_revision:25955; number_of_response:1; }","duration":"489.019758ms","start":"2026-05-05T16:24:32.610904Z","end":"2026-05-05T16:24:33.099924Z","steps":["trace[1964452350] 'process raft request'  (duration: 488.416084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.099973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.610892Z","time spent":"489.057729ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25941 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:33.430883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.204ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595811 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25942 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:33.431359Z","caller":"traceutil/trace.go:171","msg":"trace[1696448371] linearizableReadLoop","detail":"{readStateIndex:26804; appliedIndex:26803; }","duration":"331.671828ms","start":"2026-05-05T16:24:33.099667Z","end":"2026-05-05T16:24:33.431339Z","steps":["trace[1696448371] 'read index received'  (duration: 222.739091ms)","trace[1696448371] 'applied index is now lower than readState.Index'  (duration: 108.927787ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:33.431436Z","caller":"traceutil/trace.go:171","msg":"trace[728410750] transaction","detail":"{read_only:false; response_revision:25956; number_of_response:1; }","duration":"473.149997ms","start":"2026-05-05T16:24:32.958248Z","end":"2026-05-05T16:24:33.431398Z","steps":["trace[728410750] 'process raft request'  (duration: 364.141918ms)","trace[728410750] 'compare'  (duration: 107.833301ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:33.431481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.558854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-05T16:24:33.43153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.601143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-05T16:24:33.431564Z","caller":"traceutil/trace.go:171","msg":"trace[1213872573] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25956; }","duration":"346.655577ms","start":"2026-05-05T16:24:33.084887Z","end":"2026-05-05T16:24:33.431543Z","steps":["trace[1213872573] 'agreement among raft nodes before linearized reading'  (duration: 346.510003ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.43162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.084834Z","time spent":"346.77456ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T16:24:33.431621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.958234Z","time spent":"473.28068ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25942 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-05T16:24:33.431616Z","caller":"traceutil/trace.go:171","msg":"trace[667939965] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:25956; }","duration":"462.729886ms","start":"2026-05-05T16:24:32.968867Z","end":"2026-05-05T16:24:33.431596Z","steps":["trace[667939965] 'agreement among raft nodes before linearized reading'  (duration: 462.564532ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.431787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:32.96885Z","time spent":"462.91868ms","remote":"127.0.0.1:60442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T16:24:33.731639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.629852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595813 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25943 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:33.731838Z","caller":"traceutil/trace.go:171","msg":"trace[1180023343] transaction","detail":"{read_only:false; response_revision:25958; number_of_response:1; }","duration":"557.340169ms","start":"2026-05-05T16:24:33.174484Z","end":"2026-05-05T16:24:33.731824Z","steps":["trace[1180023343] 'process raft request'  (duration: 557.230007ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.731892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.174464Z","time spent":"557.403191ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25920 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-05T16:24:33.731886Z","caller":"traceutil/trace.go:171","msg":"trace[1421097124] transaction","detail":"{read_only:false; response_revision:25957; number_of_response:1; }","duration":"565.193909ms","start":"2026-05-05T16:24:33.166639Z","end":"2026-05-05T16:24:33.731833Z","steps":["trace[1421097124] 'process raft request'  (duration: 423.292279ms)","trace[1421097124] 'compare'  (duration: 141.51953ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:33.732047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.166619Z","time spent":"565.330891ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25943 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-05T16:24:33.732177Z","caller":"traceutil/trace.go:171","msg":"trace[227739023] transaction","detail":"{read_only:false; response_revision:25959; number_of_response:1; }","duration":"496.651122ms","start":"2026-05-05T16:24:33.235509Z","end":"2026-05-05T16:24:33.73216Z","steps":["trace[227739023] 'process raft request'  (duration: 496.279284ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.732251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.235483Z","time spent":"496.732584ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25945 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-05T16:24:33.732245Z","caller":"traceutil/trace.go:171","msg":"trace[1713263233] transaction","detail":"{read_only:false; response_revision:25961; number_of_response:1; }","duration":"201.549862ms","start":"2026-05-05T16:24:33.530677Z","end":"2026-05-05T16:24:33.732227Z","steps":["trace[1713263233] 'process raft request'  (duration: 201.510801ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:33.73227Z","caller":"traceutil/trace.go:171","msg":"trace[1067875117] transaction","detail":"{read_only:false; response_revision:25960; number_of_response:1; }","duration":"496.013115ms","start":"2026-05-05T16:24:33.236236Z","end":"2026-05-05T16:24:33.732249Z","steps":["trace[1067875117] 'process raft request'  (duration: 495.861062ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:33.7323Z","caller":"traceutil/trace.go:171","msg":"trace[1173978758] linearizableReadLoop","detail":"{readStateIndex:26808; appliedIndex:26804; }","duration":"300.898769ms","start":"2026-05-05T16:24:33.431389Z","end":"2026-05-05T16:24:33.732287Z","steps":["trace[1173978758] 'read index received'  (duration: 158.55654ms)","trace[1173978758] 'applied index is now lower than readState.Index'  (duration: 142.340619ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:33.73238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.236227Z","time spent":"496.090608ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25944 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:33.732412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.61526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:33.732443Z","caller":"traceutil/trace.go:171","msg":"trace[1383367484] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25961; }","duration":"543.683791ms","start":"2026-05-05T16:24:33.18875Z","end":"2026-05-05T16:24:33.732434Z","steps":["trace[1383367484] 'agreement among raft nodes before linearized reading'  (duration: 543.598399ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.732471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.188732Z","time spent":"543.730752ms","remote":"127.0.0.1:38166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T16:24:33.732489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.691358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:33.732515Z","caller":"traceutil/trace.go:171","msg":"trace[1635887023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25961; }","duration":"577.74498ms","start":"2026-05-05T16:24:33.154763Z","end":"2026-05-05T16:24:33.732508Z","steps":["trace[1635887023] 'agreement among raft nodes before linearized reading'  (duration: 577.702409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:33.732533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:33.154746Z","time spent":"577.7834ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-05T16:24:33.741982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.759723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-05T16:24:33.742063Z","caller":"traceutil/trace.go:171","msg":"trace[1447200713] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25962; }","duration":"118.890925ms","start":"2026-05-05T16:24:33.623156Z","end":"2026-05-05T16:24:33.742047Z","steps":["trace[1447200713] 'agreement among raft nodes before linearized reading'  (duration: 118.67625ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:41.814381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.286253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:41.814482Z","caller":"traceutil/trace.go:171","msg":"trace[526419951] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:26019; }","duration":"235.504288ms","start":"2026-05-05T16:24:41.57895Z","end":"2026-05-05T16:24:41.814455Z","steps":["trace[526419951] 'count revisions from in-memory index tree'  (duration: 235.170439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:41.982212Z","caller":"traceutil/trace.go:171","msg":"trace[1103206586] transaction","detail":"{read_only:false; response_revision:26020; number_of_response:1; }","duration":"220.163449ms","start":"2026-05-05T16:24:41.76202Z","end":"2026-05-05T16:24:41.982184Z","steps":["trace[1103206586] 'process raft request'  (duration: 219.982205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:42.140807Z","caller":"traceutil/trace.go:171","msg":"trace[547585240] transaction","detail":"{read_only:false; response_revision:26021; number_of_response:1; }","duration":"378.156805ms","start":"2026-05-05T16:24:41.762628Z","end":"2026-05-05T16:24:42.140785Z","steps":["trace[547585240] 'process raft request'  (duration: 377.95999ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:42.141033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:41.762603Z","time spent":"378.36069ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26004 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-05T16:24:42.141184Z","caller":"traceutil/trace.go:171","msg":"trace[241395934] linearizableReadLoop","detail":"{readStateIndex:26873; appliedIndex:26868; }","duration":"302.408205ms","start":"2026-05-05T16:24:41.838754Z","end":"2026-05-05T16:24:42.141163Z","steps":["trace[241395934] 'read index received'  (duration: 143.342614ms)","trace[241395934] 'applied index is now lower than readState.Index'  (duration: 159.064281ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:42.141188Z","caller":"traceutil/trace.go:171","msg":"trace[1057261407] transaction","detail":"{read_only:false; response_revision:26022; number_of_response:1; }","duration":"378.38182ms","start":"2026-05-05T16:24:41.76275Z","end":"2026-05-05T16:24:42.141132Z","steps":["trace[1057261407] 'process raft request'  (duration: 377.998451ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:42.141271Z","caller":"traceutil/trace.go:171","msg":"trace[1927599466] transaction","detail":"{read_only:false; response_revision:26024; number_of_response:1; }","duration":"374.010155ms","start":"2026-05-05T16:24:41.767237Z","end":"2026-05-05T16:24:42.141247Z","steps":["trace[1927599466] 'process raft request'  (duration: 373.869441ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:42.141248Z","caller":"traceutil/trace.go:171","msg":"trace[448031737] transaction","detail":"{read_only:false; response_revision:26023; number_of_response:1; }","duration":"377.826246ms","start":"2026-05-05T16:24:41.763393Z","end":"2026-05-05T16:24:42.141219Z","steps":["trace[448031737] 'process raft request'  (duration: 377.625551ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:42.141378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:41.767218Z","time spent":"374.103276ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26007 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:42.141436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.672452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:140"}
{"level":"warn","ts":"2026-05-05T16:24:42.141447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:41.762717Z","time spent":"378.603945ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26003 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:42.141444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:41.763364Z","time spent":"377.97729ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26006 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:42.141462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.207297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-05T16:24:42.141608Z","caller":"traceutil/trace.go:171","msg":"trace[960574016] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26024; }","duration":"301.36795ms","start":"2026-05-05T16:24:41.840227Z","end":"2026-05-05T16:24:42.141595Z","steps":["trace[960574016] 'agreement among raft nodes before linearized reading'  (duration: 301.121113ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:42.141624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.396439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-05T16:24:42.141657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:41.840218Z","time spent":"301.425722ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-05T16:24:42.141709Z","caller":"traceutil/trace.go:171","msg":"trace[499133663] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:26024; }","duration":"164.499702ms","start":"2026-05-05T16:24:41.977179Z","end":"2026-05-05T16:24:42.141679Z","steps":["trace[499133663] 'agreement among raft nodes before linearized reading'  (duration: 164.335648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:42.141496Z","caller":"traceutil/trace.go:171","msg":"trace[1213549918] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:26024; }","duration":"302.770744ms","start":"2026-05-05T16:24:41.838708Z","end":"2026-05-05T16:24:42.141479Z","steps":["trace[1213549918] 'agreement among raft nodes before linearized reading'  (duration: 302.572378ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:42.141829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:41.83869Z","time spent":"303.119483ms","remote":"127.0.0.1:60046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.153\" "}
{"level":"warn","ts":"2026-05-05T16:24:42.704213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.107104ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575595970 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26008 > 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:18"}
{"level":"info","ts":"2026-05-05T16:24:42.704431Z","caller":"traceutil/trace.go:171","msg":"trace[1837907001] linearizableReadLoop","detail":"{readStateIndex:26876; appliedIndex:26874; }","duration":"227.516546ms","start":"2026-05-05T16:24:42.476896Z","end":"2026-05-05T16:24:42.704413Z","steps":["trace[1837907001] 'read index received'  (duration: 190.700422ms)","trace[1837907001] 'applied index is now lower than readState.Index'  (duration: 36.814764ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:42.704507Z","caller":"traceutil/trace.go:171","msg":"trace[1378387499] transaction","detail":"{read_only:false; response_revision:26026; number_of_response:1; }","duration":"538.217731ms","start":"2026-05-05T16:24:42.166278Z","end":"2026-05-05T16:24:42.704496Z","steps":["trace[1378387499] 'process raft request'  (duration: 538.051116ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:42.704572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:42.166256Z","time spent":"538.281862ms","remote":"127.0.0.1:60046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.153\" mod_revision:25949 > success:<request_put:<key:\"/registry/masterleases/199.204.45.153\" value_size:68 lease:6432439859575595968 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.153\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:42.704996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.07575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:42.705086Z","caller":"traceutil/trace.go:171","msg":"trace[1641805203] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:26026; }","duration":"228.238334ms","start":"2026-05-05T16:24:42.476829Z","end":"2026-05-05T16:24:42.705067Z","steps":["trace[1641805203] 'agreement among raft nodes before linearized reading'  (duration: 227.990588ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:42.705093Z","caller":"traceutil/trace.go:171","msg":"trace[873144443] transaction","detail":"{read_only:false; response_revision:26025; number_of_response:1; }","duration":"559.210854ms","start":"2026-05-05T16:24:42.145848Z","end":"2026-05-05T16:24:42.705059Z","steps":["trace[873144443] 'process raft request'  (duration: 284.174127ms)","trace[873144443] 'compare'  (duration: 273.956411ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:42.705263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:42.145828Z","time spent":"559.328558ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26008 > 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-05-05T16:24:42.707081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.18359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-05T16:24:42.707137Z","caller":"traceutil/trace.go:171","msg":"trace[1889447895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26028; }","duration":"168.285952ms","start":"2026-05-05T16:24:42.538835Z","end":"2026-05-05T16:24:42.707121Z","steps":["trace[1889447895] 'agreement among raft nodes before linearized reading'  (duration: 168.154109ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:43.255781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.071465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-05T16:24:43.255856Z","caller":"traceutil/trace.go:171","msg":"trace[1708993251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26028; }","duration":"309.156577ms","start":"2026-05-05T16:24:42.946682Z","end":"2026-05-05T16:24:43.255839Z","steps":["trace[1708993251] 'range keys from in-memory index tree'  (duration: 308.915551ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:43.255898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:42.946663Z","time spent":"309.225979ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-05T16:24:43.255938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.407912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-05T16:24:43.255981Z","caller":"traceutil/trace.go:171","msg":"trace[834965303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26028; }","duration":"115.477054ms","start":"2026-05-05T16:24:43.140491Z","end":"2026-05-05T16:24:43.255969Z","steps":["trace[834965303] 'range keys from in-memory index tree'  (duration: 115.30155ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:43.255984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.75722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-05-05T16:24:43.256074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.212069ms","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-05-05T16:24:43.256093Z","caller":"traceutil/trace.go:171","msg":"trace[1369126435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26028; }","duration":"113.22978ms","start":"2026-05-05T16:24:43.142857Z","end":"2026-05-05T16:24:43.256087Z","steps":["trace[1369126435] 'range keys from in-memory index tree'  (duration: 113.141738ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:43.256085Z","caller":"traceutil/trace.go:171","msg":"trace[557652996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26028; }","duration":"115.868843ms","start":"2026-05-05T16:24:43.140192Z","end":"2026-05-05T16:24:43.256061Z","steps":["trace[557652996] 'range keys from in-memory index tree'  (duration: 115.542836ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:43.256254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.030942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:43.256273Z","caller":"traceutil/trace.go:171","msg":"trace[289768187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26028; }","duration":"100.067053ms","start":"2026-05-05T16:24:43.156201Z","end":"2026-05-05T16:24:43.256268Z","steps":["trace[289768187] 'range keys from in-memory index tree'  (duration: 99.991531ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:49.570762Z","caller":"traceutil/trace.go:171","msg":"trace[1427490741] linearizableReadLoop","detail":"{readStateIndex:26981; appliedIndex:26980; }","duration":"186.482101ms","start":"2026-05-05T16:24:49.384249Z","end":"2026-05-05T16:24:49.570731Z","steps":["trace[1427490741] 'read index received'  (duration: 186.375317ms)","trace[1427490741] 'applied index is now lower than readState.Index'  (duration: 105.704µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:49.570806Z","caller":"traceutil/trace.go:171","msg":"trace[1361518164] transaction","detail":"{read_only:false; response_revision:26130; number_of_response:1; }","duration":"203.459688ms","start":"2026-05-05T16:24:49.367314Z","end":"2026-05-05T16:24:49.570773Z","steps":["trace[1361518164] 'process raft request'  (duration: 203.261202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:49.570976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.735521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-05T16:24:49.57101Z","caller":"traceutil/trace.go:171","msg":"trace[394855285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26130; }","duration":"202.812393ms","start":"2026-05-05T16:24:49.368189Z","end":"2026-05-05T16:24:49.571002Z","steps":["trace[394855285] 'agreement among raft nodes before linearized reading'  (duration: 202.68177ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:49.702416Z","caller":"traceutil/trace.go:171","msg":"trace[924587803] transaction","detail":"{read_only:false; response_revision:26131; number_of_response:1; }","duration":"314.059486ms","start":"2026-05-05T16:24:49.388331Z","end":"2026-05-05T16:24:49.70239Z","steps":["trace[924587803] 'process raft request'  (duration: 313.573653ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:49.702609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:49.38831Z","time spent":"314.184389ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26060 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-05T16:24:49.702604Z","caller":"traceutil/trace.go:171","msg":"trace[1810260226] linearizableReadLoop","detail":"{readStateIndex:26983; appliedIndex:26981; }","duration":"131.732995ms","start":"2026-05-05T16:24:49.57084Z","end":"2026-05-05T16:24:49.702573Z","steps":["trace[1810260226] 'read index received'  (duration: 131.076229ms)","trace[1810260226] 'applied index is now lower than readState.Index'  (duration: 655.566µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:49.702797Z","caller":"traceutil/trace.go:171","msg":"trace[1142660185] transaction","detail":"{read_only:false; response_revision:26132; number_of_response:1; }","duration":"216.145963ms","start":"2026-05-05T16:24:49.486607Z","end":"2026-05-05T16:24:49.702753Z","steps":["trace[1142660185] 'process raft request'  (duration: 215.709113ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:49.702919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.443236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-05-05T16:24:49.702972Z","caller":"traceutil/trace.go:171","msg":"trace[24667394] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6; range_end:; response_count:1; response_revision:26132; }","duration":"272.558669ms","start":"2026-05-05T16:24:49.430401Z","end":"2026-05-05T16:24:49.702959Z","steps":["trace[24667394] 'agreement among raft nodes before linearized reading'  (duration: 272.371135ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:49.965779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.285154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575596267 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26061 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:49.96621Z","caller":"traceutil/trace.go:171","msg":"trace[1157787824] transaction","detail":"{read_only:false; response_revision:26133; number_of_response:1; }","duration":"391.220069ms","start":"2026-05-05T16:24:49.574956Z","end":"2026-05-05T16:24:49.966176Z","steps":["trace[1157787824] 'process raft request'  (duration: 254.455653ms)","trace[1157787824] 'compare'  (duration: 136.032457ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:49.966378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:49.574938Z","time spent":"391.353692ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26061 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-05T16:24:49.966748Z","caller":"traceutil/trace.go:171","msg":"trace[1301801868] linearizableReadLoop","detail":"{readStateIndex:26984; appliedIndex:26983; }","duration":"264.058294ms","start":"2026-05-05T16:24:49.702667Z","end":"2026-05-05T16:24:49.966726Z","steps":["trace[1301801868] 'read index received'  (duration: 126.797336ms)","trace[1301801868] 'applied index is now lower than readState.Index'  (duration: 137.257598ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:49.966937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.182413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-05-05T16:24:49.966975Z","caller":"traceutil/trace.go:171","msg":"trace[643422599] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26133; }","duration":"293.259535ms","start":"2026-05-05T16:24:49.673706Z","end":"2026-05-05T16:24:49.966965Z","steps":["trace[643422599] 'agreement among raft nodes before linearized reading'  (duration: 293.108902ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:50.052561Z","caller":"traceutil/trace.go:171","msg":"trace[1291932672] transaction","detail":"{read_only:false; response_revision:26134; number_of_response:1; }","duration":"341.001973ms","start":"2026-05-05T16:24:49.711504Z","end":"2026-05-05T16:24:50.052506Z","steps":["trace[1291932672] 'process raft request'  (duration: 340.781537ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:50.052755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:49.711485Z","time spent":"341.174336ms","remote":"127.0.0.1:60208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3743,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6\" mod_revision:26110 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6\" value_size:3643 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:50.180994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.068054ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432439859575596271 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:25967 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-05T16:24:50.181234Z","caller":"traceutil/trace.go:171","msg":"trace[1229157050] transaction","detail":"{read_only:false; response_revision:26135; number_of_response:1; }","duration":"210.307202ms","start":"2026-05-05T16:24:49.970902Z","end":"2026-05-05T16:24:50.181209Z","steps":["trace[1229157050] 'process raft request'  (duration: 94.941711ms)","trace[1229157050] 'compare'  (duration: 114.938071ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:50.181309Z","caller":"traceutil/trace.go:171","msg":"trace[556231686] linearizableReadLoop","detail":"{readStateIndex:26987; appliedIndex:26985; }","duration":"115.078855ms","start":"2026-05-05T16:24:50.066208Z","end":"2026-05-05T16:24:50.181287Z","steps":["trace[556231686] 'read index received'  (duration: 34.171µs)","trace[556231686] 'applied index is now lower than readState.Index'  (duration: 115.042934ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:50.181362Z","caller":"traceutil/trace.go:171","msg":"trace[409394065] transaction","detail":"{read_only:false; response_revision:26136; number_of_response:1; }","duration":"169.42444ms","start":"2026-05-05T16:24:50.01192Z","end":"2026-05-05T16:24:50.181345Z","steps":["trace[409394065] 'process raft request'  (duration: 169.170014ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:50.181915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.69583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6\" ","response":"range_response_count:1 size:3761"}
{"level":"info","ts":"2026-05-05T16:24:50.181982Z","caller":"traceutil/trace.go:171","msg":"trace[1852612906] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-808414ad-96d1-4900-8c33-4e78370363e6; range_end:; response_count:1; response_revision:26136; }","duration":"115.763922ms","start":"2026-05-05T16:24:50.066201Z","end":"2026-05-05T16:24:50.181965Z","steps":["trace[1852612906] 'agreement among raft nodes before linearized reading'  (duration: 115.230769ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:56.210104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.112451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:56.210202Z","caller":"traceutil/trace.go:171","msg":"trace[632034738] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:26202; }","duration":"141.258074ms","start":"2026-05-05T16:24:56.06892Z","end":"2026-05-05T16:24:56.210178Z","steps":["trace[632034738] 'count revisions from in-memory index tree'  (duration: 140.917556ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:56.571067Z","caller":"traceutil/trace.go:171","msg":"trace[1864677520] linearizableReadLoop","detail":"{readStateIndex:27059; appliedIndex:27055; }","duration":"181.948671ms","start":"2026-05-05T16:24:56.389096Z","end":"2026-05-05T16:24:56.571045Z","steps":["trace[1864677520] 'read index received'  (duration: 181.630503ms)","trace[1864677520] 'applied index is now lower than readState.Index'  (duration: 316.998µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:24:56.571212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.091975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:56.571253Z","caller":"traceutil/trace.go:171","msg":"trace[2103708521] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:26207; }","duration":"182.150096ms","start":"2026-05-05T16:24:56.389091Z","end":"2026-05-05T16:24:56.571241Z","steps":["trace[2103708521] 'agreement among raft nodes before linearized reading'  (duration: 182.041074ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:56.571594Z","caller":"traceutil/trace.go:171","msg":"trace[963632378] transaction","detail":"{read_only:false; response_revision:26204; number_of_response:1; }","duration":"356.445024ms","start":"2026-05-05T16:24:56.215137Z","end":"2026-05-05T16:24:56.571582Z","steps":["trace[963632378] 'process raft request'  (duration: 355.602263ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:56.571681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:56.215121Z","time spent":"356.507056ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26180 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-05T16:24:56.571832Z","caller":"traceutil/trace.go:171","msg":"trace[1680701121] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"322.403445ms","start":"2026-05-05T16:24:56.249419Z","end":"2026-05-05T16:24:56.571822Z","steps":["trace[1680701121] 'process raft request'  (duration: 321.486602ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:56.571891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:56.249394Z","time spent":"322.467077ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26181 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-05T16:24:56.572042Z","caller":"traceutil/trace.go:171","msg":"trace[710405122] transaction","detail":"{read_only:false; response_revision:26206; number_of_response:1; }","duration":"319.300681ms","start":"2026-05-05T16:24:56.252732Z","end":"2026-05-05T16:24:56.572033Z","steps":["trace[710405122] 'process raft request'  (duration: 318.218984ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:56.572227Z","caller":"traceutil/trace.go:171","msg":"trace[631282292] transaction","detail":"{read_only:false; response_revision:26207; number_of_response:1; }","duration":"319.319111ms","start":"2026-05-05T16:24:56.252895Z","end":"2026-05-05T16:24:56.572214Z","steps":["trace[631282292] 'process raft request'  (duration: 318.104842ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:56.572289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:56.252871Z","time spent":"319.384302ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26183 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-05T16:24:56.573135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:24:56.252714Z","time spent":"319.349252ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26182 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-05T16:24:56.898514Z","caller":"traceutil/trace.go:171","msg":"trace[451524215] transaction","detail":"{read_only:false; response_revision:26208; number_of_response:1; }","duration":"136.191231ms","start":"2026-05-05T16:24:56.762294Z","end":"2026-05-05T16:24:56.898485Z","steps":["trace[451524215] 'process raft request'  (duration: 135.992526ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:24:56.899522Z","caller":"traceutil/trace.go:171","msg":"trace[2083986696] linearizableReadLoop","detail":"{readStateIndex:27061; appliedIndex:27059; }","duration":"127.36816ms","start":"2026-05-05T16:24:56.772136Z","end":"2026-05-05T16:24:56.899504Z","steps":["trace[2083986696] 'read index received'  (duration: 126.192181ms)","trace[2083986696] 'applied index is now lower than readState.Index'  (duration: 1.174889ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:24:56.899658Z","caller":"traceutil/trace.go:171","msg":"trace[8391267] transaction","detail":"{read_only:false; response_revision:26209; number_of_response:1; }","duration":"135.425705ms","start":"2026-05-05T16:24:56.764221Z","end":"2026-05-05T16:24:56.899647Z","steps":["trace[8391267] 'process raft request'  (duration: 135.172869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:56.899722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.514773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:24:56.899781Z","caller":"traceutil/trace.go:171","msg":"trace[1580191338] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:26209; }","duration":"102.609896ms","start":"2026-05-05T16:24:56.797156Z","end":"2026-05-05T16:24:56.899766Z","steps":["trace[1580191338] 'agreement among raft nodes before linearized reading'  (duration: 102.498483ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:24:56.899888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.728929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-05T16:24:56.900089Z","caller":"traceutil/trace.go:171","msg":"trace[1790820073] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26209; }","duration":"127.966155ms","start":"2026-05-05T16:24:56.772109Z","end":"2026-05-05T16:24:56.900075Z","steps":["trace[1790820073] 'agreement among raft nodes before linearized reading'  (duration: 127.646247ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:03.680876Z","caller":"traceutil/trace.go:171","msg":"trace[620309041] transaction","detail":"{read_only:false; response_revision:26278; number_of_response:1; }","duration":"219.901602ms","start":"2026-05-05T16:25:03.460921Z","end":"2026-05-05T16:25:03.680822Z","steps":["trace[620309041] 'process raft request'  (duration: 219.495502ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:03.941673Z","caller":"traceutil/trace.go:171","msg":"trace[156256923] transaction","detail":"{read_only:false; response_revision:26279; number_of_response:1; }","duration":"241.961142ms","start":"2026-05-05T16:25:03.699693Z","end":"2026-05-05T16:25:03.941654Z","steps":["trace[156256923] 'process raft request'  (duration: 238.802337ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:03.951246Z","caller":"traceutil/trace.go:171","msg":"trace[615144628] transaction","detail":"{read_only:false; response_revision:26280; number_of_response:1; }","duration":"170.65777ms","start":"2026-05-05T16:25:03.780572Z","end":"2026-05-05T16:25:03.95123Z","steps":["trace[615144628] 'process raft request'  (duration: 170.531297ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:03.951434Z","caller":"traceutil/trace.go:171","msg":"trace[133390135] transaction","detail":"{read_only:false; response_revision:26281; number_of_response:1; }","duration":"129.382188ms","start":"2026-05-05T16:25:03.822026Z","end":"2026-05-05T16:25:03.951408Z","steps":["trace[133390135] 'process raft request'  (duration: 129.175473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:04.084874Z","caller":"traceutil/trace.go:171","msg":"trace[1603240534] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"128.319953ms","start":"2026-05-05T16:25:03.956518Z","end":"2026-05-05T16:25:04.084838Z","steps":["trace[1603240534] 'process raft request'  (duration: 126.843447ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:04.539255Z","caller":"traceutil/trace.go:171","msg":"trace[102308312] linearizableReadLoop","detail":"{readStateIndex:27138; appliedIndex:27137; }","duration":"161.291635ms","start":"2026-05-05T16:25:04.377936Z","end":"2026-05-05T16:25:04.539228Z","steps":["trace[102308312] 'read index received'  (duration: 161.07445ms)","trace[102308312] 'applied index is now lower than readState.Index'  (duration: 216.285µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:25:04.539332Z","caller":"traceutil/trace.go:171","msg":"trace[1774349500] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"218.019288ms","start":"2026-05-05T16:25:04.321263Z","end":"2026-05-05T16:25:04.539282Z","steps":["trace[1774349500] 'process raft request'  (duration: 217.804493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:04.53942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.46489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:25:04.539464Z","caller":"traceutil/trace.go:171","msg":"trace[754077752] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:26284; }","duration":"161.588462ms","start":"2026-05-05T16:25:04.377861Z","end":"2026-05-05T16:25:04.53945Z","steps":["trace[754077752] 'agreement among raft nodes before linearized reading'  (duration: 161.49586ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:04.539631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.7656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-05-05T16:25:04.539703Z","caller":"traceutil/trace.go:171","msg":"trace[1068060515] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26284; }","duration":"147.862353ms","start":"2026-05-05T16:25:04.391823Z","end":"2026-05-05T16:25:04.539685Z","steps":["trace[1068060515] 'agreement among raft nodes before linearized reading'  (duration: 147.661988ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:08.34613Z","caller":"traceutil/trace.go:171","msg":"trace[1199027123] transaction","detail":"{read_only:false; response_revision:26319; number_of_response:1; }","duration":"157.246357ms","start":"2026-05-05T16:25:08.188856Z","end":"2026-05-05T16:25:08.346103Z","steps":["trace[1199027123] 'process raft request'  (duration: 67.970992ms)","trace[1199027123] 'compare'  (duration: 89.167643ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:25:10.086411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.362965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-05T16:25:10.086537Z","caller":"traceutil/trace.go:171","msg":"trace[1957619012] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26333; }","duration":"121.55093ms","start":"2026-05-05T16:25:09.964955Z","end":"2026-05-05T16:25:10.086506Z","steps":["trace[1957619012] 'range keys from in-memory index tree'  (duration: 121.14286ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:10.08651Z","caller":"traceutil/trace.go:171","msg":"trace[1390903839] transaction","detail":"{read_only:false; response_revision:26334; number_of_response:1; }","duration":"118.839564ms","start":"2026-05-05T16:25:09.96763Z","end":"2026-05-05T16:25:10.086469Z","steps":["trace[1390903839] 'process raft request'  (duration: 77.48964ms)","trace[1390903839] 'compare'  (duration: 41.20162ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:25:24.613075Z","caller":"traceutil/trace.go:171","msg":"trace[1085780522] linearizableReadLoop","detail":"{readStateIndex:27322; appliedIndex:27320; }","duration":"101.771565ms","start":"2026-05-05T16:25:24.511282Z","end":"2026-05-05T16:25:24.613053Z","steps":["trace[1085780522] 'read index received'  (duration: 23.390723ms)","trace[1085780522] 'applied index is now lower than readState.Index'  (duration: 78.379672ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:25:24.613175Z","caller":"traceutil/trace.go:171","msg":"trace[1126684138] transaction","detail":"{read_only:false; response_revision:26463; number_of_response:1; }","duration":"164.167235ms","start":"2026-05-05T16:25:24.448978Z","end":"2026-05-05T16:25:24.613145Z","steps":["trace[1126684138] 'process raft request'  (duration: 163.779365ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:24.613283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.991651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-05T16:25:24.613322Z","caller":"traceutil/trace.go:171","msg":"trace[1345625357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26463; }","duration":"102.073843ms","start":"2026-05-05T16:25:24.511237Z","end":"2026-05-05T16:25:24.613311Z","steps":["trace[1345625357] 'agreement among raft nodes before linearized reading'  (duration: 101.923969ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:24.837328Z","caller":"traceutil/trace.go:171","msg":"trace[776032391] transaction","detail":"{read_only:false; response_revision:26465; number_of_response:1; }","duration":"122.043523ms","start":"2026-05-05T16:25:24.715246Z","end":"2026-05-05T16:25:24.83729Z","steps":["trace[776032391] 'process raft request'  (duration: 107.166984ms)","trace[776032391] 'compare'  (duration: 14.486688ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:25:24.879861Z","caller":"traceutil/trace.go:171","msg":"trace[264216343] transaction","detail":"{read_only:false; response_revision:26466; number_of_response:1; }","duration":"145.557957ms","start":"2026-05-05T16:25:24.734286Z","end":"2026-05-05T16:25:24.879844Z","steps":["trace[264216343] 'process raft request'  (duration: 145.429024ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:24.880035Z","caller":"traceutil/trace.go:171","msg":"trace[1326809609] transaction","detail":"{read_only:false; response_revision:26467; number_of_response:1; }","duration":"136.412717ms","start":"2026-05-05T16:25:24.743616Z","end":"2026-05-05T16:25:24.880029Z","steps":["trace[1326809609] 'process raft request'  (duration: 136.198742ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:24.880327Z","caller":"traceutil/trace.go:171","msg":"trace[2133342839] transaction","detail":"{read_only:false; response_revision:26468; number_of_response:1; }","duration":"134.646985ms","start":"2026-05-05T16:25:24.745673Z","end":"2026-05-05T16:25:24.88032Z","steps":["trace[2133342839] 'process raft request'  (duration: 134.331928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:24.880337Z","caller":"traceutil/trace.go:171","msg":"trace[162097570] transaction","detail":"{read_only:false; response_revision:26469; number_of_response:1; }","duration":"127.839582ms","start":"2026-05-05T16:25:24.752473Z","end":"2026-05-05T16:25:24.880313Z","steps":["trace[162097570] 'process raft request'  (duration: 127.75135ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:26.724893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.819241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-05T16:25:26.724984Z","caller":"traceutil/trace.go:171","msg":"trace[1042282847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26476; }","duration":"105.956125ms","start":"2026-05-05T16:25:26.619005Z","end":"2026-05-05T16:25:26.724961Z","steps":["trace[1042282847] 'range keys from in-memory index tree'  (duration: 105.649127ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:28.938534Z","caller":"traceutil/trace.go:171","msg":"trace[44727821] transaction","detail":"{read_only:false; response_revision:26490; number_of_response:1; }","duration":"107.124025ms","start":"2026-05-05T16:25:28.831382Z","end":"2026-05-05T16:25:28.938506Z","steps":["trace[44727821] 'process raft request'  (duration: 106.909189ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138335Z","caller":"traceutil/trace.go:171","msg":"trace[821148029] transaction","detail":"{read_only:false; response_revision:26493; number_of_response:1; }","duration":"258.329446ms","start":"2026-05-05T16:25:28.879974Z","end":"2026-05-05T16:25:29.138304Z","steps":["trace[821148029] 'process raft request'  (duration: 258.161272ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138363Z","caller":"traceutil/trace.go:171","msg":"trace[90895625] transaction","detail":"{read_only:false; response_revision:26494; number_of_response:1; }","duration":"247.065505ms","start":"2026-05-05T16:25:28.891282Z","end":"2026-05-05T16:25:29.138347Z","steps":["trace[90895625] 'process raft request'  (duration: 246.938422ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138383Z","caller":"traceutil/trace.go:171","msg":"trace[1035406730] linearizableReadLoop","detail":"{readStateIndex:27357; appliedIndex:27349; }","duration":"201.00854ms","start":"2026-05-05T16:25:28.937354Z","end":"2026-05-05T16:25:29.138363Z","steps":["trace[1035406730] 'read index received'  (duration: 904.652µs)","trace[1035406730] 'applied index is now lower than readState.Index'  (duration: 200.103118ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:25:29.138376Z","caller":"traceutil/trace.go:171","msg":"trace[139246956] transaction","detail":"{read_only:false; response_revision:26492; number_of_response:1; }","duration":"258.847609ms","start":"2026-05-05T16:25:28.879497Z","end":"2026-05-05T16:25:29.138345Z","steps":["trace[139246956] 'process raft request'  (duration: 258.44474ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138439Z","caller":"traceutil/trace.go:171","msg":"trace[528224111] transaction","detail":"{read_only:false; response_revision:26495; number_of_response:1; }","duration":"246.768418ms","start":"2026-05-05T16:25:28.891657Z","end":"2026-05-05T16:25:29.138425Z","steps":["trace[528224111] 'process raft request'  (duration: 246.596224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138439Z","caller":"traceutil/trace.go:171","msg":"trace[1725854730] transaction","detail":"{read_only:false; response_revision:26496; number_of_response:1; }","duration":"246.666596ms","start":"2026-05-05T16:25:28.89174Z","end":"2026-05-05T16:25:29.138406Z","steps":["trace[1725854730] 'process raft request'  (duration: 246.545353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138451Z","caller":"traceutil/trace.go:171","msg":"trace[1214117355] transaction","detail":"{read_only:false; response_revision:26497; number_of_response:1; }","duration":"245.906828ms","start":"2026-05-05T16:25:28.892517Z","end":"2026-05-05T16:25:29.138424Z","steps":["trace[1214117355] 'process raft request'  (duration: 245.802666ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:29.138499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.123982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:25:29.138538Z","caller":"traceutil/trace.go:171","msg":"trace[311661441] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26497; }","duration":"201.204914ms","start":"2026-05-05T16:25:28.93732Z","end":"2026-05-05T16:25:29.138525Z","steps":["trace[311661441] 'agreement among raft nodes before linearized reading'  (duration: 201.127612ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.138684Z","caller":"traceutil/trace.go:171","msg":"trace[1690635599] transaction","detail":"{read_only:false; response_revision:26491; number_of_response:1; }","duration":"272.110637ms","start":"2026-05-05T16:25:28.865876Z","end":"2026-05-05T16:25:29.137987Z","steps":["trace[1690635599] 'process raft request'  (duration: 271.876721ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.226208Z","caller":"traceutil/trace.go:171","msg":"trace[1485701504] transaction","detail":"{read_only:false; response_revision:26500; number_of_response:1; }","duration":"216.006159ms","start":"2026-05-05T16:25:29.010175Z","end":"2026-05-05T16:25:29.226181Z","steps":["trace[1485701504] 'process raft request'  (duration: 215.892976ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.226259Z","caller":"traceutil/trace.go:171","msg":"trace[1062695696] transaction","detail":"{read_only:false; response_revision:26498; number_of_response:1; }","duration":"221.930471ms","start":"2026-05-05T16:25:29.004306Z","end":"2026-05-05T16:25:29.226236Z","steps":["trace[1062695696] 'process raft request'  (duration: 214.522194ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:29.226381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.008988ms","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-05-05T16:25:29.226461Z","caller":"traceutil/trace.go:171","msg":"trace[343323714] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26500; }","duration":"191.131601ms","start":"2026-05-05T16:25:29.035312Z","end":"2026-05-05T16:25:29.226444Z","steps":["trace[343323714] 'agreement among raft nodes before linearized reading'  (duration: 190.955467ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:25:29.226522Z","caller":"traceutil/trace.go:171","msg":"trace[744741117] transaction","detail":"{read_only:false; response_revision:26499; number_of_response:1; }","duration":"220.675521ms","start":"2026-05-05T16:25:29.005834Z","end":"2026-05-05T16:25:29.22651Z","steps":["trace[744741117] 'process raft request'  (duration: 220.163119ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T16:25:29.227447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.566591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:25:29.227512Z","caller":"traceutil/trace.go:171","msg":"trace[1673946637] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:26500; }","duration":"121.681384ms","start":"2026-05-05T16:25:29.105814Z","end":"2026-05-05T16:25:29.227496Z","steps":["trace[1673946637] 'agreement among raft nodes before linearized reading'  (duration: 121.563661ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:26:11.327203Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006cd2.wal"}
{"level":"info","ts":"2026-05-05T16:27:27.91356Z","caller":"traceutil/trace.go:171","msg":"trace[1547969012] transaction","detail":"{read_only:false; response_revision:27657; number_of_response:1; }","duration":"114.110612ms","start":"2026-05-05T16:27:27.79939Z","end":"2026-05-05T16:27:27.913501Z","steps":["trace[1547969012] 'process raft request'  (duration: 114.048931ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:27:27.913904Z","caller":"traceutil/trace.go:171","msg":"trace[1616706626] transaction","detail":"{read_only:false; response_revision:27656; number_of_response:1; }","duration":"114.732186ms","start":"2026-05-05T16:27:27.799127Z","end":"2026-05-05T16:27:27.913859Z","steps":["trace[1616706626] 'process raft request'  (duration: 19.175781ms)","trace[1616706626] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:420; } (duration: 94.409818ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:27:38.614901Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24905}
{"level":"info","ts":"2026-05-05T16:27:38.758853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24905,"took":"140.235799ms","hash":3854880640,"current-db-size-bytes":59232256,"current-db-size":"59 MB","current-db-size-in-use-bytes":36687872,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-05-05T16:27:38.759085Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3854880640,"revision":24905,"compact-revision":21781}
{"level":"info","ts":"2026-05-05T16:28:47.24255Z","caller":"traceutil/trace.go:171","msg":"trace[344411823] linearizableReadLoop","detail":"{readStateIndex:29385; appliedIndex:29383; }","duration":"103.510037ms","start":"2026-05-05T16:28:47.139019Z","end":"2026-05-05T16:28:47.242529Z","steps":["trace[344411823] 'read index received'  (duration: 59.388557ms)","trace[344411823] 'applied index is now lower than readState.Index'  (duration: 44.12051ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T16:28:47.24273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.67648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-05T16:28:47.242812Z","caller":"traceutil/trace.go:171","msg":"trace[185877484] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:28476; }","duration":"103.809183ms","start":"2026-05-05T16:28:47.138982Z","end":"2026-05-05T16:28:47.242791Z","steps":["trace[185877484] 'agreement among raft nodes before linearized reading'  (duration: 103.639499ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:28:48.189019Z","caller":"traceutil/trace.go:171","msg":"trace[91707476] transaction","detail":"{read_only:false; response_revision:28480; number_of_response:1; }","duration":"147.334018ms","start":"2026-05-05T16:28:48.041662Z","end":"2026-05-05T16:28:48.188996Z","steps":["trace[91707476] 'process raft request'  (duration: 117.675926ms)","trace[91707476] 'compare'  (duration: 29.205851ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T16:28:48.20381Z","caller":"traceutil/trace.go:171","msg":"trace[735275813] transaction","detail":"{read_only:false; response_revision:28482; number_of_response:1; }","duration":"159.069161ms","start":"2026-05-05T16:28:48.044717Z","end":"2026-05-05T16:28:48.203786Z","steps":["trace[735275813] 'process raft request'  (duration: 158.982979ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:28:48.203839Z","caller":"traceutil/trace.go:171","msg":"trace[1781282659] transaction","detail":"{read_only:false; response_revision:28481; number_of_response:1; }","duration":"159.231874ms","start":"2026-05-05T16:28:48.044574Z","end":"2026-05-05T16:28:48.203806Z","steps":["trace[1781282659] 'process raft request'  (duration: 158.923047ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:28:48.204125Z","caller":"traceutil/trace.go:171","msg":"trace[917809885] transaction","detail":"{read_only:false; response_revision:28483; number_of_response:1; }","duration":"158.158329ms","start":"2026-05-05T16:28:48.045942Z","end":"2026-05-05T16:28:48.204101Z","steps":["trace[917809885] 'process raft request'  (duration: 157.79723ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:28:48.204256Z","caller":"traceutil/trace.go:171","msg":"trace[516039812] transaction","detail":"{read_only:false; response_revision:28484; number_of_response:1; }","duration":"157.478872ms","start":"2026-05-05T16:28:48.046728Z","end":"2026-05-05T16:28:48.204206Z","steps":["trace[516039812] 'process raft request'  (duration: 157.254106ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T16:29:52.239201Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T16:29:52.244218Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-05T16:29:52.244334Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-05T16:32:38.620341Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27764}
{"level":"info","ts":"2026-05-05T16:32:38.748135Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27764,"took":"125.016003ms","hash":3947185739,"current-db-size-bytes":59232256,"current-db-size":"59 MB","current-db-size-in-use-bytes":32923648,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-05T16:32:38.748189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3947185739,"revision":27764,"compact-revision":24905}
{"level":"info","ts":"2026-05-05T16:37:38.627271Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30332}
{"level":"info","ts":"2026-05-05T16:37:38.757601Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30332,"took":"127.129113ms","hash":3363122220,"current-db-size-bytes":59232256,"current-db-size":"59 MB","current-db-size-in-use-bytes":30138368,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-05T16:37:38.757658Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3363122220,"revision":30332,"compact-revision":27764}
{"level":"info","ts":"2026-05-05T16:42:38.638501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32588}
{"level":"info","ts":"2026-05-05T16:42:38.77275Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32588,"took":"130.165397ms","hash":2138904585,"current-db-size-bytes":59232256,"current-db-size":"59 MB","current-db-size-in-use-bytes":30633984,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-05T16:42:38.772818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2138904585,"revision":32588,"compact-revision":30332}
{"level":"info","ts":"2026-05-05T16:47:38.645969Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34877}
{"level":"info","ts":"2026-05-05T16:47:38.793644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34877,"took":"143.053165ms","hash":3954779781,"current-db-size-bytes":59695104,"current-db-size":"60 MB","current-db-size-in-use-bytes":31879168,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-05T16:47:38.793714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3954779781,"revision":34877,"compact-revision":32588}
{"level":"info","ts":"2026-05-05T16:51:16.870361Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T16:51:16.876059Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-05T16:51:16.876298Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-05T16:52:38.651809Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37121}
{"level":"info","ts":"2026-05-05T16:52:38.780462Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37121,"took":"124.235494ms","hash":4177511824,"current-db-size-bytes":61382656,"current-db-size":"61 MB","current-db-size-in-use-bytes":31506432,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-05T16:52:38.780521Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4177511824,"revision":37121,"compact-revision":34877}