{"level":"warn","ts":"2026-04-20T20:50:41.043137Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T20:50:41.043218Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233: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.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-20T20:50:41.043283Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T20:50:41.043291Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]}
{"level":"info","ts":"2026-04-20T20:50:41.04331Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-20T20:50:41.043913Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]}
{"level":"info","ts":"2026-04-20T20:50:41.043986Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-20T20:50:41.049035Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.795335ms"}
{"level":"info","ts":"2026-04-20T20:50:41.054602Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"}
{"level":"info","ts":"2026-04-20T20:50:41.054673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-20T20:50:41.054693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"}
{"level":"info","ts":"2026-04-20T20:50:41.054707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-20T20:50:41.054721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"}
{"level":"info","ts":"2026-04-20T20:50:41.054756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"}
{"level":"warn","ts":"2026-04-20T20:50:41.061956Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-20T20:50:41.063105Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-20T20:50:41.065408Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-20T20:50:41.067416Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-20T20:50:41.067642Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-20T20:50:41.067784Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-20T20:50:41.068354Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-20T20:50:41.068365Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-20T20:50:41.069253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"}
{"level":"info","ts":"2026-04-20T20:50:41.074033Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]}
{"level":"info","ts":"2026-04-20T20:50:41.076738Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-20T20:50:41.076829Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"}
{"level":"info","ts":"2026-04-20T20:50:41.076921Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"}
{"level":"info","ts":"2026-04-20T20:50:41.07771Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-20T20:50:41.077765Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-20T20:50:41.855588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-20T20:50:41.85566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-20T20:50:41.855683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"}
{"level":"info","ts":"2026-04-20T20:50:41.855702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"}
{"level":"info","ts":"2026-04-20T20:50:41.855713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"}
{"level":"info","ts":"2026-04-20T20:50:41.85573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"}
{"level":"info","ts":"2026-04-20T20:50:41.855744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"}
{"level":"info","ts":"2026-04-20T20:50:41.856706Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T20:50:41.857642Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T20:50:41.857645Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-20T20:50:41.857657Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T20:50:41.857979Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-20T20:50:41.858022Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-20T20:50:41.858715Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T20:50:41.858829Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T20:50:41.858864Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T20:50:41.860613Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"}
{"level":"info","ts":"2026-04-20T20:50:41.860822Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-04-20T20:50:45.294949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.008604ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4581741560812347371 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/roles/kube-system/kubeadm:nodes-kubeadm-config\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/kube-system/kubeadm:nodes-kubeadm-config\" value_size:278 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-20T20:50:45.295231Z","caller":"traceutil/trace.go:171","msg":"trace[1723778928] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"318.31701ms","start":"2026-04-20T20:50:44.976877Z","end":"2026-04-20T20:50:45.295194Z","steps":["trace[1723778928] 'process raft request'  (duration: 144.555375ms)","trace[1723778928] 'compare'  (duration: 172.889046ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:50:45.295404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:50:44.976858Z","time spent":"318.468458ms","remote":"127.0.0.1:45766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/roles/kube-system/kubeadm:nodes-kubeadm-config\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/kube-system/kubeadm:nodes-kubeadm-config\" value_size:278 >> failure:<>"}
{"level":"info","ts":"2026-04-20T20:50:45.432782Z","caller":"traceutil/trace.go:171","msg":"trace[229899888] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"133.575296ms","start":"2026-04-20T20:50:45.299184Z","end":"2026-04-20T20:50:45.432759Z","steps":["trace[229899888] 'process raft request'  (duration: 133.432948ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:50:45.433517Z","caller":"traceutil/trace.go:171","msg":"trace[968983303] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"133.889733ms","start":"2026-04-20T20:50:45.299594Z","end":"2026-04-20T20:50:45.433484Z","steps":["trace[968983303] 'process raft request'  (duration: 133.705252ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:51:18.745808Z","caller":"traceutil/trace.go:171","msg":"trace[1719623172] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"240.984563ms","start":"2026-04-20T20:51:18.504787Z","end":"2026-04-20T20:51:18.745772Z","steps":["trace[1719623172] 'read index received'  (duration: 234.60314ms)","trace[1719623172] 'applied index is now lower than readState.Index'  (duration: 6.380503ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:51:18.74606Z","caller":"traceutil/trace.go:171","msg":"trace[1636728825] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"399.411314ms","start":"2026-04-20T20:51:18.346611Z","end":"2026-04-20T20:51:18.746023Z","steps":["trace[1636728825] 'process raft request'  (duration: 392.872089ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:51:18.746346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:18.34658Z","time spent":"399.698193ms","remote":"127.0.0.1:45940","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":"warn","ts":"2026-04-20T20:51:18.746128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.385291ms","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-04-20T20:51:18.746517Z","caller":"traceutil/trace.go:171","msg":"trace[1692017160] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"241.822142ms","start":"2026-04-20T20:51:18.504668Z","end":"2026-04-20T20:51:18.746491Z","steps":["trace[1692017160] 'agreement among raft nodes before linearized reading'  (duration: 241.239871ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:52:03.116871Z","caller":"traceutil/trace.go:171","msg":"trace[82718478] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"150.687063ms","start":"2026-04-20T20:52:02.966148Z","end":"2026-04-20T20:52:03.116835Z","steps":["trace[82718478] 'process raft request'  (duration: 150.461592ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:52:50.749985Z","caller":"traceutil/trace.go:171","msg":"trace[1431872880] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"233.073363ms","start":"2026-04-20T20:52:50.516892Z","end":"2026-04-20T20:52:50.749965Z","steps":["trace[1431872880] 'process raft request'  (duration: 232.92729ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:50.750167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.666326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10630"}
{"level":"info","ts":"2026-04-20T20:52:50.750264Z","caller":"traceutil/trace.go:171","msg":"trace[689837031] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1801; }","duration":"232.814769ms","start":"2026-04-20T20:52:50.517433Z","end":"2026-04-20T20:52:50.750248Z","steps":["trace[689837031] 'agreement among raft nodes before linearized reading'  (duration: 232.565505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:52:50.74999Z","caller":"traceutil/trace.go:171","msg":"trace[1758330171] linearizableReadLoop","detail":"{readStateIndex:1867; appliedIndex:1867; }","duration":"232.484973ms","start":"2026-04-20T20:52:50.517469Z","end":"2026-04-20T20:52:50.749954Z","steps":["trace[1758330171] 'read index received'  (duration: 232.471303ms)","trace[1758330171] 'applied index is now lower than readState.Index'  (duration: 11.81µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:52:51.022115Z","caller":"traceutil/trace.go:171","msg":"trace[1405269784] linearizableReadLoop","detail":"{readStateIndex:1868; appliedIndex:1867; }","duration":"271.576828ms","start":"2026-04-20T20:52:50.750508Z","end":"2026-04-20T20:52:51.022085Z","steps":["trace[1405269784] 'read index received'  (duration: 246.302675ms)","trace[1405269784] 'applied index is now lower than readState.Index'  (duration: 25.272503ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:52:51.022356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.262185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T20:52:51.022408Z","caller":"traceutil/trace.go:171","msg":"trace[765786952] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1802; }","duration":"458.341056ms","start":"2026-04-20T20:52:50.564052Z","end":"2026-04-20T20:52:51.022393Z","steps":["trace[765786952] 'agreement among raft nodes before linearized reading'  (duration: 458.269365ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:51.022452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:52:50.564036Z","time spent":"458.402526ms","remote":"127.0.0.1:45870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":11,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"info","ts":"2026-04-20T20:52:51.022155Z","caller":"traceutil/trace.go:171","msg":"trace[1569526615] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"342.581022ms","start":"2026-04-20T20:52:50.679536Z","end":"2026-04-20T20:52:51.022117Z","steps":["trace[1569526615] 'process raft request'  (duration: 317.184857ms)","trace[1569526615] 'compare'  (duration: 24.891677ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:52:51.022269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.160665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a82bf1520a5f50\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-04-20T20:52:51.022735Z","caller":"traceutil/trace.go:171","msg":"trace[1665264336] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a82bf1520a5f50; range_end:; response_count:1; response_revision:1802; }","duration":"353.641062ms","start":"2026-04-20T20:52:50.669045Z","end":"2026-04-20T20:52:51.022686Z","steps":["trace[1665264336] 'agreement among raft nodes before linearized reading'  (duration: 353.062563ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:51.022832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:52:50.669026Z","time spent":"353.775275ms","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1005,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a82bf1520a5f50\" "}
{"level":"warn","ts":"2026-04-20T20:52:51.022852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:52:50.679524Z","time spent":"343.032188ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1774 > 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-04-20T20:52:51.172207Z","caller":"traceutil/trace.go:171","msg":"trace[1760308869] linearizableReadLoop","detail":"{readStateIndex:1869; appliedIndex:1868; }","duration":"149.809783ms","start":"2026-04-20T20:52:51.022375Z","end":"2026-04-20T20:52:51.172184Z","steps":["trace[1760308869] 'read index received'  (duration: 145.152311ms)","trace[1760308869] 'applied index is now lower than readState.Index'  (duration: 4.656602ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:52:51.172392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.089621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-20T20:52:51.172424Z","caller":"traceutil/trace.go:171","msg":"trace[1258215953] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1803; }","duration":"319.175562ms","start":"2026-04-20T20:52:50.853237Z","end":"2026-04-20T20:52:51.172413Z","steps":["trace[1258215953] 'agreement among raft nodes before linearized reading'  (duration: 319.05287ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:51.172449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:52:50.853213Z","time spent":"319.228763ms","remote":"127.0.0.1:55286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-04-20T20:52:51.172384Z","caller":"traceutil/trace.go:171","msg":"trace[2081528100] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"410.36136ms","start":"2026-04-20T20:52:50.761985Z","end":"2026-04-20T20:52:51.172347Z","steps":["trace[2081528100] 'process raft request'  (duration: 405.451455ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:51.172756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:52:50.761966Z","time spent":"410.649124ms","remote":"127.0.0.1:45600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10932,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1749 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10875 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"info","ts":"2026-04-20T20:52:51.206337Z","caller":"traceutil/trace.go:171","msg":"trace[943003487] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"181.515377ms","start":"2026-04-20T20:52:51.024795Z","end":"2026-04-20T20:52:51.20631Z","steps":["trace[943003487] 'process raft request'  (duration: 181.312144ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:51.206841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.873402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-04-20T20:52:51.207373Z","caller":"traceutil/trace.go:171","msg":"trace[2086317615] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1804; }","duration":"112.41697ms","start":"2026-04-20T20:52:51.094902Z","end":"2026-04-20T20:52:51.207319Z","steps":["trace[2086317615] 'agreement among raft nodes before linearized reading'  (duration: 111.73323ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:52:51.407153Z","caller":"traceutil/trace.go:171","msg":"trace[647879381] linearizableReadLoop","detail":"{readStateIndex:1875; appliedIndex:1874; }","duration":"175.477195ms","start":"2026-04-20T20:52:51.231648Z","end":"2026-04-20T20:52:51.407125Z","steps":["trace[647879381] 'read index received'  (duration: 87.871824ms)","trace[647879381] 'applied index is now lower than readState.Index'  (duration: 87.604181ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:52:51.407432Z","caller":"traceutil/trace.go:171","msg":"trace[1238157490] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"195.314499ms","start":"2026-04-20T20:52:51.212103Z","end":"2026-04-20T20:52:51.407417Z","steps":["trace[1238157490] 'process raft request'  (duration: 107.305542ms)","trace[1238157490] 'compare'  (duration: 87.605331ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:52:51.407551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.873921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T20:52:51.407643Z","caller":"traceutil/trace.go:171","msg":"trace[119148191] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1809; }","duration":"176.006303ms","start":"2026-04-20T20:52:51.231607Z","end":"2026-04-20T20:52:51.407613Z","steps":["trace[119148191] 'agreement among raft nodes before linearized reading'  (duration: 175.84044ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:52:51.408936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.844778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T20:52:51.408992Z","caller":"traceutil/trace.go:171","msg":"trace[1774781960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1810; }","duration":"101.912899ms","start":"2026-04-20T20:52:51.307067Z","end":"2026-04-20T20:52:51.40898Z","steps":["trace[1774781960] 'agreement among raft nodes before linearized reading'  (duration: 101.812277ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:52:51.408979Z","caller":"traceutil/trace.go:171","msg":"trace[2075028860] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"175.654846ms","start":"2026-04-20T20:52:51.233297Z","end":"2026-04-20T20:52:51.408952Z","steps":["trace[2075028860] 'process raft request'  (duration: 175.471924ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:53:38.969678Z","caller":"traceutil/trace.go:171","msg":"trace[1711421114] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"100.099601ms","start":"2026-04-20T20:53:38.869526Z","end":"2026-04-20T20:53:38.969626Z","steps":["trace[1711421114] 'process raft request'  (duration: 62.420842ms)","trace[1711421114] 'compare'  (duration: 36.690669ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:54:20.651697Z","caller":"traceutil/trace.go:171","msg":"trace[22442155] transaction","detail":"{read_only:false; response_revision:2447; number_of_response:1; }","duration":"131.964375ms","start":"2026-04-20T20:54:20.519717Z","end":"2026-04-20T20:54:20.651682Z","steps":["trace[22442155] 'process raft request'  (duration: 131.87064ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:54:20.652353Z","caller":"traceutil/trace.go:171","msg":"trace[532640135] linearizableReadLoop","detail":"{readStateIndex:2535; appliedIndex:2533; }","duration":"124.545669ms","start":"2026-04-20T20:54:20.527783Z","end":"2026-04-20T20:54:20.652328Z","steps":["trace[532640135] 'read index received'  (duration: 123.880916ms)","trace[532640135] 'applied index is now lower than readState.Index'  (duration: 663.483µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:54:20.652389Z","caller":"traceutil/trace.go:171","msg":"trace[758521789] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"131.734812ms","start":"2026-04-20T20:54:20.520646Z","end":"2026-04-20T20:54:20.652381Z","steps":["trace[758521789] 'process raft request'  (duration: 131.548723ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:54:20.652533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.724568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-04-20T20:54:20.652567Z","caller":"traceutil/trace.go:171","msg":"trace[2096983748] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2448; }","duration":"124.812382ms","start":"2026-04-20T20:54:20.527748Z","end":"2026-04-20T20:54:20.65256Z","steps":["trace[2096983748] 'agreement among raft nodes before linearized reading'  (duration: 124.663925ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T20:54:20.652681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.350298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-20T20:54:20.652724Z","caller":"traceutil/trace.go:171","msg":"trace[867228977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2448; }","duration":"123.58432ms","start":"2026-04-20T20:54:20.529129Z","end":"2026-04-20T20:54:20.652713Z","steps":["trace[867228977] 'agreement among raft nodes before linearized reading'  (duration: 123.431522ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:54:53.990205Z","caller":"traceutil/trace.go:171","msg":"trace[2125334758] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"159.362704ms","start":"2026-04-20T20:54:53.830811Z","end":"2026-04-20T20:54:53.990174Z","steps":["trace[2125334758] 'process raft request'  (duration: 158.713758ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:54:54.208076Z","caller":"traceutil/trace.go:171","msg":"trace[1169299371] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"176.657847ms","start":"2026-04-20T20:54:54.031387Z","end":"2026-04-20T20:54:54.208045Z","steps":["trace[1169299371] 'process raft request'  (duration: 176.611205ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:54:54.208154Z","caller":"traceutil/trace.go:171","msg":"trace[430707306] linearizableReadLoop","detail":"{readStateIndex:2726; appliedIndex:2725; }","duration":"177.515185ms","start":"2026-04-20T20:54:54.03063Z","end":"2026-04-20T20:54:54.208145Z","steps":["trace[430707306] 'read index received'  (duration: 114.299996ms)","trace[430707306] 'applied index is now lower than readState.Index'  (duration: 63.214119ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:54:54.208089Z","caller":"traceutil/trace.go:171","msg":"trace[1856298837] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"213.913419ms","start":"2026-04-20T20:54:53.994145Z","end":"2026-04-20T20:54:54.208059Z","steps":["trace[1856298837] 'process raft request'  (duration: 150.765514ms)","trace[1856298837] 'compare'  (duration: 62.974476ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:54:54.208301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.655783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-04-20T20:54:54.208985Z","caller":"traceutil/trace.go:171","msg":"trace[1518814394] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2633; }","duration":"178.380393ms","start":"2026-04-20T20:54:54.030594Z","end":"2026-04-20T20:54:54.208974Z","steps":["trace[1518814394] 'agreement among raft nodes before linearized reading'  (duration: 177.584099ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:58:38.083158Z","caller":"traceutil/trace.go:171","msg":"trace[6068528] transaction","detail":"{read_only:false; response_revision:4549; number_of_response:1; }","duration":"119.213842ms","start":"2026-04-20T20:58:37.963915Z","end":"2026-04-20T20:58:38.083129Z","steps":["trace[6068528] 'process raft request'  (duration: 58.699119ms)","trace[6068528] 'compare'  (duration: 59.903415ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:58:38.08636Z","caller":"traceutil/trace.go:171","msg":"trace[140290164] transaction","detail":"{read_only:false; response_revision:4550; number_of_response:1; }","duration":"120.182791ms","start":"2026-04-20T20:58:37.96616Z","end":"2026-04-20T20:58:38.086343Z","steps":["trace[140290164] 'process raft request'  (duration: 120.091398ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:58:50.2112Z","caller":"traceutil/trace.go:171","msg":"trace[602128021] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"241.806896ms","start":"2026-04-20T20:58:49.969353Z","end":"2026-04-20T20:58:50.211159Z","steps":["trace[602128021] 'process raft request'  (duration: 145.937429ms)","trace[602128021] 'compare'  (duration: 95.66622ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T20:58:50.211304Z","caller":"traceutil/trace.go:171","msg":"trace[548895442] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"232.116405ms","start":"2026-04-20T20:58:49.979168Z","end":"2026-04-20T20:58:50.211284Z","steps":["trace[548895442] 'process raft request'  (duration: 231.939099ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:58:50.28287Z","caller":"traceutil/trace.go:171","msg":"trace[1625879746] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"151.588678ms","start":"2026-04-20T20:58:50.131252Z","end":"2026-04-20T20:58:50.282841Z","steps":["trace[1625879746] 'process raft request'  (duration: 151.421392ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T20:58:50.296469Z","caller":"traceutil/trace.go:171","msg":"trace[406470448] linearizableReadLoop","detail":"{readStateIndex:4951; appliedIndex:4949; }","duration":"125.699729ms","start":"2026-04-20T20:58:50.170747Z","end":"2026-04-20T20:58:50.296447Z","steps":["trace[406470448] 'read index received'  (duration: 111.991137ms)","trace[406470448] 'applied index is now lower than readState.Index'  (duration: 13.707222ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T20:58:50.296699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.935708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-20T20:58:50.296787Z","caller":"traceutil/trace.go:171","msg":"trace[2104823924] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4777; }","duration":"126.067723ms","start":"2026-04-20T20:58:50.170701Z","end":"2026-04-20T20:58:50.296768Z","steps":["trace[2104823924] 'agreement among raft nodes before linearized reading'  (duration: 125.834384ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T21:00:41.886927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886}
{"level":"info","ts":"2026-04-20T21:00:41.965836Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"77.119455ms","hash":3027492327,"current-db-size-bytes":54513664,"current-db-size":"54 MB","current-db-size-in-use-bytes":29421568,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-20T21:00:41.965892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3027492327,"revision":2886,"compact-revision":-1}
{"level":"info","ts":"2026-04-20T21:02:22.609486Z","caller":"traceutil/trace.go:171","msg":"trace[1574308901] transaction","detail":"{read_only:false; response_revision:6322; number_of_response:1; }","duration":"101.141227ms","start":"2026-04-20T21:02:22.508305Z","end":"2026-04-20T21:02:22.609446Z","steps":["trace[1574308901] 'process raft request'  (duration: 101.032131ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.419556Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812362686,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T21:03:11.565099Z","caller":"traceutil/trace.go:171","msg":"trace[352068581] transaction","detail":"{read_only:false; response_revision:6632; number_of_response:1; }","duration":"687.910408ms","start":"2026-04-20T21:03:10.877168Z","end":"2026-04-20T21:03:11.565078Z","steps":["trace[352068581] 'process raft request'  (duration: 687.74991ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.565245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:10.877157Z","time spent":"688.003053ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:6620 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T21:03:11.800735Z","caller":"traceutil/trace.go:171","msg":"trace[1468508122] linearizableReadLoop","detail":"{readStateIndex:6872; appliedIndex:6869; }","duration":"881.699087ms","start":"2026-04-20T21:03:10.918998Z","end":"2026-04-20T21:03:11.800697Z","steps":["trace[1468508122] 'read index received'  (duration: 645.911578ms)","trace[1468508122] 'applied index is now lower than readState.Index'  (duration: 235.786669ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T21:03:11.801045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.291854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T21:03:11.801091Z","caller":"traceutil/trace.go:171","msg":"trace[1262234721] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:6634; }","duration":"829.350987ms","start":"2026-04-20T21:03:10.971728Z","end":"2026-04-20T21:03:11.801079Z","steps":["trace[1262234721] 'agreement among raft nodes before linearized reading'  (duration: 829.269323ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.801133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:10.971662Z","time spent":"829.459712ms","remote":"127.0.0.1:45570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":4,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T21:03:11.801176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.17057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" ","response":"range_response_count:4 size:81053"}
{"level":"info","ts":"2026-04-20T21:03:11.801235Z","caller":"traceutil/trace.go:171","msg":"trace[1891142029] range","detail":"{range_begin:/registry/secrets/auth-system/; range_end:/registry/secrets/auth-system0; response_count:4; response_revision:6634; }","duration":"882.262015ms","start":"2026-04-20T21:03:10.918958Z","end":"2026-04-20T21:03:11.80122Z","steps":["trace[1891142029] 'agreement among raft nodes before linearized reading'  (duration: 881.896007ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.801278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:10.918941Z","time spent":"882.326108ms","remote":"127.0.0.1:45528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":81076,"request content":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" "}
{"level":"warn","ts":"2026-04-20T21:03:11.801411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.456033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-20T21:03:11.801451Z","caller":"traceutil/trace.go:171","msg":"trace[550820715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6634; }","duration":"239.568609ms","start":"2026-04-20T21:03:11.561873Z","end":"2026-04-20T21:03:11.801441Z","steps":["trace[550820715] 'agreement among raft nodes before linearized reading'  (duration: 239.468744ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T21:03:11.801484Z","caller":"traceutil/trace.go:171","msg":"trace[1169837064] transaction","detail":"{read_only:false; response_revision:6633; number_of_response:1; }","duration":"618.939294ms","start":"2026-04-20T21:03:11.182531Z","end":"2026-04-20T21:03:11.80147Z","steps":["trace[1169837064] 'process raft request'  (duration: 527.583213ms)","trace[1169837064] 'compare'  (duration: 90.14339ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T21:03:11.801582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.182506Z","time spent":"619.024118ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:6621 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-20T21:03:11.801627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.679857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-20T21:03:11.801662Z","caller":"traceutil/trace.go:171","msg":"trace[2131363084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6634; }","duration":"332.745871ms","start":"2026-04-20T21:03:11.468907Z","end":"2026-04-20T21:03:11.801653Z","steps":["trace[2131363084] 'agreement among raft nodes before linearized reading'  (duration: 332.662787ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.801695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.468891Z","time spent":"332.796853ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-20T21:03:11.801774Z","caller":"traceutil/trace.go:171","msg":"trace[1141335413] transaction","detail":"{read_only:false; response_revision:6634; number_of_response:1; }","duration":"447.593972ms","start":"2026-04-20T21:03:11.354167Z","end":"2026-04-20T21:03:11.801761Z","steps":["trace[1141335413] 'process raft request'  (duration: 446.476306ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.801855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.389822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-04-20T21:03:11.801858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.354035Z","time spent":"447.779542ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:6623 > 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-04-20T21:03:11.801934Z","caller":"traceutil/trace.go:171","msg":"trace[1511954163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6634; }","duration":"369.499148ms","start":"2026-04-20T21:03:11.432426Z","end":"2026-04-20T21:03:11.801925Z","steps":["trace[1511954163] 'agreement among raft nodes before linearized reading'  (duration: 369.376221ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.801968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.43241Z","time spent":"369.551481ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-20T21:03:11.802089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.251998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-20T21:03:11.80212Z","caller":"traceutil/trace.go:171","msg":"trace[413456150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6634; }","duration":"534.312982ms","start":"2026-04-20T21:03:11.2678Z","end":"2026-04-20T21:03:11.802112Z","steps":["trace[413456150] 'agreement among raft nodes before linearized reading'  (duration: 534.231958ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.802151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.267783Z","time spent":"534.362823ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T21:03:11.802266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.162627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-04-20T21:03:11.802299Z","caller":"traceutil/trace.go:171","msg":"trace[1811342214] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6634; }","duration":"583.225179ms","start":"2026-04-20T21:03:11.219066Z","end":"2026-04-20T21:03:11.802291Z","steps":["trace[1811342214] 'agreement among raft nodes before linearized reading'  (duration: 583.151176ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.802331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.219049Z","time spent":"583.276132ms","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-04-20T21:03:11.802444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.582532ms","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-04-20T21:03:11.802473Z","caller":"traceutil/trace.go:171","msg":"trace[1312444050] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6634; }","duration":"602.649205ms","start":"2026-04-20T21:03:11.199817Z","end":"2026-04-20T21:03:11.802466Z","steps":["trace[1312444050] 'agreement among raft nodes before linearized reading'  (duration: 602.569161ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:11.802505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:11.199716Z","time spent":"602.782992ms","remote":"127.0.0.1:45600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-20T21:03:42.221228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:42.722034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:43.222496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:43.722687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:44.223784Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:44.300051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999857244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-20T21:03:44.300106Z","caller":"traceutil/trace.go:171","msg":"trace[2122251676] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999957689s","start":"2026-04-20T21:03:42.300134Z","end":"2026-04-20T21:03:44.300091Z","steps":["trace[2122251676] 'agreement among raft nodes before linearized reading'  (duration: 1.999890666s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:44.300186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.300116Z","time spent":"2.000059335s","remote":"127.0.0.1:45428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/20 21:03:44 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-20T21:03:44.307396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00054792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-20T21:03:44.307486Z","caller":"traceutil/trace.go:171","msg":"trace[1864877860] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000666357s","start":"2026-04-20T21:03:42.306799Z","end":"2026-04-20T21:03:44.307465Z","steps":["trace[1864877860] 'agreement among raft nodes before linearized reading'  (duration: 2.000571732s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:44.307541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.306787Z","time spent":"2.00073702s","remote":"127.0.0.1:45412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/20 21:03:44 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-20T21:03:44.72414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:45.224485Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:45.725396Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:46.22647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:46.315237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000007378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-20T21:03:46.315315Z","caller":"traceutil/trace.go:171","msg":"trace[1513407443] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000151925s","start":"2026-04-20T21:03:44.315145Z","end":"2026-04-20T21:03:46.315297Z","steps":["trace[1513407443] 'agreement among raft nodes before linearized reading'  (duration: 2.000037229s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.315464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.31513Z","time spent":"2.000275961s","remote":"127.0.0.1:45428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/20 21:03:46 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-20T21:03:46.727024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741560812363209,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-20T21:03:46.832899Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.383033549s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-20T21:03:46.833336Z","caller":"traceutil/trace.go:171","msg":"trace[1997740157] transaction","detail":"{read_only:false; response_revision:6809; number_of_response:1; }","duration":"5.383533944s","start":"2026-04-20T21:03:41.449776Z","end":"2026-04-20T21:03:46.83331Z","steps":["trace[1997740157] 'process raft request'  (duration: 5.383392007s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.833536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:41.449758Z","time spent":"5.3836502s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:6756 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-04-20T21:03:46.835016Z","caller":"traceutil/trace.go:171","msg":"trace[184741118] linearizableReadLoop","detail":"{readStateIndex:7057; appliedIndex:7052; }","duration":"5.114664364s","start":"2026-04-20T21:03:41.720329Z","end":"2026-04-20T21:03:46.834994Z","steps":["trace[184741118] 'read index received'  (duration: 5.112874523s)","trace[184741118] 'applied index is now lower than readState.Index'  (duration: 1.788941ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T21:03:46.835118Z","caller":"traceutil/trace.go:171","msg":"trace[853602902] transaction","detail":"{read_only:false; response_revision:6812; number_of_response:1; }","duration":"4.756083233s","start":"2026-04-20T21:03:42.079019Z","end":"2026-04-20T21:03:46.835102Z","steps":["trace[853602902] 'process raft request'  (duration: 4.755862002s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.835255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.078993Z","time spent":"4.756159266s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:6806 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-20T21:03:46.835378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.303376Z","time spent":"2.532001272s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-04-20T21:03:46.835422Z","caller":"traceutil/trace.go:171","msg":"trace[1876155411] transaction","detail":"{read_only:false; response_revision:6810; number_of_response:1; }","duration":"4.914225539s","start":"2026-04-20T21:03:41.921178Z","end":"2026-04-20T21:03:46.835404Z","steps":["trace[1876155411] 'process raft request'  (duration: 4.913483652s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.835543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:41.921158Z","time spent":"4.914319654s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:6800 > 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-04-20T21:03:46.835691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.115359209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-04-20T21:03:46.835743Z","caller":"traceutil/trace.go:171","msg":"trace[816696994] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6812; }","duration":"5.115436512s","start":"2026-04-20T21:03:41.720294Z","end":"2026-04-20T21:03:46.835731Z","steps":["trace[816696994] 'agreement among raft nodes before linearized reading'  (duration: 5.115298756s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.835776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:41.720281Z","time spent":"5.115487995s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-20T21:03:46.83584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.925795147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-04-20T21:03:46.835909Z","caller":"traceutil/trace.go:171","msg":"trace[969129947] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6812; }","duration":"4.925896862s","start":"2026-04-20T21:03:41.909995Z","end":"2026-04-20T21:03:46.835892Z","steps":["trace[969129947] 'agreement among raft nodes before linearized reading'  (duration: 4.925704472s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.835938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.918294748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T21:03:46.835957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:41.909978Z","time spent":"4.925966805s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-04-20T21:03:46.835988Z","caller":"traceutil/trace.go:171","msg":"trace[673354217] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:6812; }","duration":"3.918379214s","start":"2026-04-20T21:03:42.917599Z","end":"2026-04-20T21:03:46.835979Z","steps":["trace[673354217] 'agreement among raft nodes before linearized reading'  (duration: 3.91830809s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.836027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.917581Z","time spent":"3.918436387s","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T21:03:46.836187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.651772762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T21:03:46.836225Z","caller":"traceutil/trace.go:171","msg":"trace[1613999921] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:6812; }","duration":"2.651808354s","start":"2026-04-20T21:03:44.184405Z","end":"2026-04-20T21:03:46.836214Z","steps":["trace[1613999921] 'agreement among raft nodes before linearized reading'  (duration: 2.651748011s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.836227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.064860789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-04-20T21:03:46.836545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.501358452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-20T21:03:46.835038Z","caller":"traceutil/trace.go:171","msg":"trace[622508038] transaction","detail":"{read_only:false; response_revision:6811; number_of_response:1; }","duration":"4.91031056s","start":"2026-04-20T21:03:41.924706Z","end":"2026-04-20T21:03:46.835016Z","steps":["trace[622508038] 'process raft request'  (duration: 4.910140012s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T21:03:46.836598Z","caller":"traceutil/trace.go:171","msg":"trace[419029086] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:6812; }","duration":"2.501463108s","start":"2026-04-20T21:03:44.335122Z","end":"2026-04-20T21:03:46.836585Z","steps":["trace[419029086] 'agreement among raft nodes before linearized reading'  (duration: 2.500934521s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.836669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.335106Z","time spent":"2.501550562s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":669,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T21:03:46.836981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.115997854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.233\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-04-20T21:03:46.837024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.184369Z","time spent":"2.652632167s","remote":"127.0.0.1:45862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T21:03:46.837239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.728627002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T21:03:46.837329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.793856903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-20T21:03:46.837371Z","caller":"traceutil/trace.go:171","msg":"trace[383542141] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:6812; }","duration":"2.728701035s","start":"2026-04-20T21:03:44.108566Z","end":"2026-04-20T21:03:46.837267Z","steps":["trace[383542141] 'agreement among raft nodes before linearized reading'  (duration: 2.728641362s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T21:03:46.837412Z","caller":"traceutil/trace.go:171","msg":"trace[1989467842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6812; }","duration":"4.793935817s","start":"2026-04-20T21:03:42.043428Z","end":"2026-04-20T21:03:46.837364Z","steps":["trace[1989467842] 'agreement among raft nodes before linearized reading'  (duration: 4.79379708s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.837495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.043411Z","time spent":"4.794038382s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T21:03:46.837462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.108546Z","time spent":"2.728896495s","remote":"127.0.0.1:48710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T21:03:46.837626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.061232258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-haproxy\" ","response":"range_response_count:1 size:410972"}
{"level":"info","ts":"2026-04-20T21:03:46.83773Z","caller":"traceutil/trace.go:171","msg":"trace[80288788] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-haproxy; range_end:; response_count:1; response_revision:6812; }","duration":"2.061389046s","start":"2026-04-20T21:03:44.776314Z","end":"2026-04-20T21:03:46.837703Z","steps":["trace[80288788] 'agreement among raft nodes before linearized reading'  (duration: 2.05989656s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.837796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.776294Z","time spent":"2.061490201s","remote":"127.0.0.1:45532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":410995,"request content":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-haproxy\" "}
{"level":"info","ts":"2026-04-20T21:03:46.837023Z","caller":"traceutil/trace.go:171","msg":"trace[2049518717] range","detail":"{range_begin:/registry/masterleases/199.204.45.233; range_end:; response_count:1; response_revision:6812; }","duration":"2.116097659s","start":"2026-04-20T21:03:44.720915Z","end":"2026-04-20T21:03:46.837013Z","steps":["trace[2049518717] 'agreement among raft nodes before linearized reading'  (duration: 2.115992284s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.837913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.450138212s","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-04-20T21:03:46.837989Z","caller":"traceutil/trace.go:171","msg":"trace[90038111] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6812; }","duration":"4.450242958s","start":"2026-04-20T21:03:42.387732Z","end":"2026-04-20T21:03:46.837975Z","steps":["trace[90038111] 'agreement among raft nodes before linearized reading'  (duration: 4.450037067s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.838059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.387714Z","time spent":"4.450306741s","remote":"127.0.0.1:45600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-20T21:03:46.838079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.863192526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-04-20T21:03:46.838087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.805687304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-20T21:03:46.83816Z","caller":"traceutil/trace.go:171","msg":"trace[7053235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6812; }","duration":"4.80580397s","start":"2026-04-20T21:03:42.032334Z","end":"2026-04-20T21:03:46.838138Z","steps":["trace[7053235] 'agreement among raft nodes before linearized reading'  (duration: 4.805572618s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.838221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.032318Z","time spent":"4.805894145s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-20T21:03:46.838226Z","caller":"traceutil/trace.go:171","msg":"trace[1196823290] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6812; }","duration":"4.863250449s","start":"2026-04-20T21:03:41.974869Z","end":"2026-04-20T21:03:46.83812Z","steps":["trace[1196823290] 'agreement among raft nodes before linearized reading'  (duration: 4.863102841s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.837937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:44.720898Z","time spent":"2.117028235s","remote":"127.0.0.1:45464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.233\" "}
{"level":"warn","ts":"2026-04-20T21:03:46.8383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:41.974828Z","time spent":"4.863453429s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-20T21:03:46.837714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.180543839s","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:5"}
{"level":"info","ts":"2026-04-20T21:03:46.838478Z","caller":"traceutil/trace.go:171","msg":"trace[484662948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:6812; }","duration":"4.181349539s","start":"2026-04-20T21:03:42.657116Z","end":"2026-04-20T21:03:46.838465Z","steps":["trace[484662948] 'agreement among raft nodes before linearized reading'  (duration: 4.180523828s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.837799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.828345648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T21:03:46.838521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.657098Z","time spent":"4.181409603s","remote":"127.0.0.1:48690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"info","ts":"2026-04-20T21:03:46.838538Z","caller":"traceutil/trace.go:171","msg":"trace[1834758636] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:6812; }","duration":"3.829113077s","start":"2026-04-20T21:03:43.009406Z","end":"2026-04-20T21:03:46.838519Z","steps":["trace[1834758636] 'agreement among raft nodes before linearized reading'  (duration: 3.828361149s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.83861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:43.009386Z","time spent":"3.829203742s","remote":"127.0.0.1:34260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T21:03:46.838242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.696562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T21:03:46.838723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.79518556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-20T21:03:46.838755Z","caller":"traceutil/trace.go:171","msg":"trace[122392739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6812; }","duration":"4.795242054s","start":"2026-04-20T21:03:42.043502Z","end":"2026-04-20T21:03:46.838744Z","steps":["trace[122392739] 'agreement among raft nodes before linearized reading'  (duration: 4.795158019s)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.838799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.043484Z","time spent":"4.795308147s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-20T21:03:46.83627Z","caller":"traceutil/trace.go:171","msg":"trace[990847148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6812; }","duration":"4.064939013s","start":"2026-04-20T21:03:42.771318Z","end":"2026-04-20T21:03:46.836257Z","steps":["trace[990847148] 'agreement among raft nodes before linearized reading'  (duration: 4.064824437s)"],"step_count":1}
{"level":"info","ts":"2026-04-20T21:03:46.838805Z","caller":"traceutil/trace.go:171","msg":"trace[306164010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6812; }","duration":"523.242289ms","start":"2026-04-20T21:03:46.315498Z","end":"2026-04-20T21:03:46.83874Z","steps":["trace[306164010] 'agreement among raft nodes before linearized reading'  (duration: 522.696042ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T21:03:46.838856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:42.7713Z","time spent":"4.067538965s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T21:03:46.838858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:46.315482Z","time spent":"523.361906ms","remote":"127.0.0.1:45412","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-04-20T21:03:46.836694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T21:03:41.924692Z","time spent":"4.911943093s","remote":"127.0.0.1:45686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:6801 > 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-04-20T21:05:41.891919Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5618}
{"level":"info","ts":"2026-04-20T21:05:41.966748Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5618,"took":"73.72901ms","hash":667279016,"current-db-size-bytes":54513664,"current-db-size":"54 MB","current-db-size-in-use-bytes":18034688,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-20T21:05:41.966796Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":667279016,"revision":5618,"compact-revision":2886}