{"level":"warn","ts":"2026-04-08T05:46:58.553834Z","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-08T05:46:58.553917Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-08T05:46:58.553983Z","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-08T05:46:58.553993Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-04-08T05:46:58.554009Z","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-08T05:46:58.554617Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]}
{"level":"info","ts":"2026-04-08T05:46:58.554688Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-08T05:46:58.558532Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.604432ms"}
{"level":"info","ts":"2026-04-08T05:46:58.565116Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"}
{"level":"info","ts":"2026-04-08T05:46:58.565184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-08T05:46:58.565203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"}
{"level":"info","ts":"2026-04-08T05:46:58.565217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-08T05:46:58.565223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"}
{"level":"info","ts":"2026-04-08T05:46:58.565251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"warn","ts":"2026-04-08T05:46:58.570273Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-08T05:46:58.572143Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-08T05:46:58.573201Z","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-08T05:46:58.574753Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-08T05:46:58.575071Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-08T05:46:58.575011Z","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-08T05:46:58.576133Z","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-08T05:46:58.576226Z","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-08T05:46:58.576591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"info","ts":"2026-04-08T05:46:58.576999Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-04-08T05:46:58.578359Z","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-08T05:46:58.578427Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-04-08T05:46:58.578467Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-04-08T05:46:58.578695Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-08T05:46:58.578751Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-08T05:46:59.265657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-08T05:46:59.2657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-08T05:46:59.265724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"}
{"level":"info","ts":"2026-04-08T05:46:59.26574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"}
{"level":"info","ts":"2026-04-08T05:46:59.265745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-04-08T05:46:59.265753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"}
{"level":"info","ts":"2026-04-08T05:46:59.26576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-04-08T05:46:59.266684Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T05:46:59.268125Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T05:46:59.268213Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T05:46:59.268233Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T05:46:59.268254Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-08T05:46:59.268421Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T05:46:59.268992Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T05:46:59.26921Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-08T05:46:59.269238Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-08T05:46:59.271656Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-08T05:46:59.27405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"}
{"level":"info","ts":"2026-04-08T05:47:27.988766Z","caller":"traceutil/trace.go:171","msg":"trace[2069898486] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"151.624911ms","start":"2026-04-08T05:47:27.837113Z","end":"2026-04-08T05:47:27.988738Z","steps":["trace[2069898486] 'process raft request'  (duration: 145.097641ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:47:27.989553Z","caller":"traceutil/trace.go:171","msg":"trace[1790362927] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"152.124491ms","start":"2026-04-08T05:47:27.837396Z","end":"2026-04-08T05:47:27.98952Z","steps":["trace[1790362927] 'process raft request'  (duration: 151.793414ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:47:33.619031Z","caller":"traceutil/trace.go:171","msg":"trace[1677820794] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"112.633401ms","start":"2026-04-08T05:47:33.506376Z","end":"2026-04-08T05:47:33.619009Z","steps":["trace[1677820794] 'process raft request'  (duration: 112.151212ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:47:33.948741Z","caller":"traceutil/trace.go:171","msg":"trace[739807727] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"275.288293ms","start":"2026-04-08T05:47:33.673418Z","end":"2026-04-08T05:47:33.948706Z","steps":["trace[739807727] 'process raft request'  (duration: 275.011938ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:47:34.100563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.08397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T05:47:34.10066Z","caller":"traceutil/trace.go:171","msg":"trace[127208318] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:573; }","duration":"140.237473ms","start":"2026-04-08T05:47:33.960407Z","end":"2026-04-08T05:47:34.100644Z","steps":["trace[127208318] 'range keys from in-memory index tree'  (duration: 140.005529ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:47:34.100666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.53534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x8zmg\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-08T05:47:34.100754Z","caller":"traceutil/trace.go:171","msg":"trace[1202107774] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x8zmg; range_end:; response_count:1; response_revision:573; }","duration":"101.663352ms","start":"2026-04-08T05:47:33.999071Z","end":"2026-04-08T05:47:34.100735Z","steps":["trace[1202107774] 'range keys from in-memory index tree'  (duration: 101.283434ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:48:15.860586Z","caller":"traceutil/trace.go:171","msg":"trace[1320511876] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"237.999843ms","start":"2026-04-08T05:48:15.622521Z","end":"2026-04-08T05:48:15.860521Z","steps":["trace[1320511876] 'process raft request'  (duration: 237.782088ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:49:00.603643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.179052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T05:49:00.60375Z","caller":"traceutil/trace.go:171","msg":"trace[8142950] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1793; }","duration":"145.358436ms","start":"2026-04-08T05:49:00.458369Z","end":"2026-04-08T05:49:00.603727Z","steps":["trace[8142950] 'count revisions from in-memory index tree'  (duration: 145.093571ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:49:00.603742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.618751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"}
{"level":"info","ts":"2026-04-08T05:49:00.603822Z","caller":"traceutil/trace.go:171","msg":"trace[1622673492] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1793; }","duration":"143.719884ms","start":"2026-04-08T05:49:00.460078Z","end":"2026-04-08T05:49:00.603798Z","steps":["trace[1622673492] 'range keys from in-memory index tree'  (duration: 143.468478ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:49:00.814595Z","caller":"traceutil/trace.go:171","msg":"trace[268356086] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"104.89878ms","start":"2026-04-08T05:49:00.709671Z","end":"2026-04-08T05:49:00.81457Z","steps":["trace[268356086] 'process raft request'  (duration: 104.710976ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:49:00.814933Z","caller":"traceutil/trace.go:171","msg":"trace[1038810743] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"104.889449ms","start":"2026-04-08T05:49:00.709947Z","end":"2026-04-08T05:49:00.814837Z","steps":["trace[1038810743] 'process raft request'  (duration: 104.552093ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:49:00.815183Z","caller":"traceutil/trace.go:171","msg":"trace[140300285] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"105.027222ms","start":"2026-04-08T05:49:00.709966Z","end":"2026-04-08T05:49:00.814993Z","steps":["trace[140300285] 'process raft request'  (duration: 104.755987ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:49:01.060438Z","caller":"traceutil/trace.go:171","msg":"trace[52399715] linearizableReadLoop","detail":"{readStateIndex:1869; appliedIndex:1868; }","duration":"136.570192ms","start":"2026-04-08T05:49:00.923835Z","end":"2026-04-08T05:49:01.060406Z","steps":["trace[52399715] 'read index received'  (duration: 111.159236ms)","trace[52399715] 'applied index is now lower than readState.Index'  (duration: 25.409606ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T05:49:01.060744Z","caller":"traceutil/trace.go:171","msg":"trace[187497783] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"152.855746ms","start":"2026-04-08T05:49:00.907851Z","end":"2026-04-08T05:49:01.060707Z","steps":["trace[187497783] 'process raft request'  (duration: 127.199955ms)","trace[187497783] 'compare'  (duration: 25.211682ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T05:49:01.060757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.897298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T05:49:01.060953Z","caller":"traceutil/trace.go:171","msg":"trace[1345433257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1801; }","duration":"137.143612ms","start":"2026-04-08T05:49:00.923788Z","end":"2026-04-08T05:49:01.060932Z","steps":["trace[1345433257] 'agreement among raft nodes before linearized reading'  (duration: 136.893627ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:49:12.402133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.684573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-08T05:49:12.402227Z","caller":"traceutil/trace.go:171","msg":"trace[1209836178] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:1899; }","duration":"129.835026ms","start":"2026-04-08T05:49:12.27237Z","end":"2026-04-08T05:49:12.402205Z","steps":["trace[1209836178] 'range keys from in-memory index tree'  (duration: 129.437149ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:49:51.45397Z","caller":"traceutil/trace.go:171","msg":"trace[734673280] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"188.597188ms","start":"2026-04-08T05:49:51.265337Z","end":"2026-04-08T05:49:51.453934Z","steps":["trace[734673280] 'process raft request'  (duration: 188.205709ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:49:51.70575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.016442ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975056921 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2114 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T05:49:51.706029Z","caller":"traceutil/trace.go:171","msg":"trace[1526400524] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"247.390619ms","start":"2026-04-08T05:49:51.458599Z","end":"2026-04-08T05:49:51.70599Z","steps":["trace[1526400524] 'process raft request'  (duration: 21.451598ms)","trace[1526400524] 'compare'  (duration: 224.825009ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T05:49:51.706248Z","caller":"traceutil/trace.go:171","msg":"trace[237412985] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"247.063573ms","start":"2026-04-08T05:49:51.459151Z","end":"2026-04-08T05:49:51.706214Z","steps":["trace[237412985] 'process raft request'  (duration: 246.758197ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:49:51.706418Z","caller":"traceutil/trace.go:171","msg":"trace[1716962965] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"247.147405ms","start":"2026-04-08T05:49:51.45922Z","end":"2026-04-08T05:49:51.706368Z","steps":["trace[1716962965] 'process raft request'  (duration: 246.757097ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:51:14.57261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.967059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T05:51:14.57278Z","caller":"traceutil/trace.go:171","msg":"trace[203188705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2770; }","duration":"102.208423ms","start":"2026-04-08T05:51:14.470545Z","end":"2026-04-08T05:51:14.572753Z","steps":["trace[203188705] 'count revisions from in-memory index tree'  (duration: 101.868916ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:51:14.938487Z","caller":"traceutil/trace.go:171","msg":"trace[1360763185] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"111.853725ms","start":"2026-04-08T05:51:14.826606Z","end":"2026-04-08T05:51:14.93846Z","steps":["trace[1360763185] 'process raft request'  (duration: 111.668481ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:55:16.749045Z","caller":"traceutil/trace.go:171","msg":"trace[1413684373] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"199.465948ms","start":"2026-04-08T05:55:16.549534Z","end":"2026-04-08T05:55:16.749Z","steps":["trace[1413684373] 'process raft request'  (duration: 173.249869ms)","trace[1413684373] 'compare'  (duration: 25.523376ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T05:55:16.870109Z","caller":"traceutil/trace.go:171","msg":"trace[1147407576] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"318.983565ms","start":"2026-04-08T05:55:16.551084Z","end":"2026-04-08T05:55:16.870068Z","steps":["trace[1147407576] 'process raft request'  (duration: 316.348693ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:55:16.870389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:55:16.551067Z","time spent":"319.142898ms","remote":"127.0.0.1:37608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a60902e-4360-4a6b-9d2c-6c42b6038ecf\" mod_revision:4939 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a60902e-4360-4a6b-9d2c-6c42b6038ecf\" value_size:3606 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a60902e-4360-4a6b-9d2c-6c42b6038ecf\" > >"}
{"level":"info","ts":"2026-04-08T05:55:16.87411Z","caller":"traceutil/trace.go:171","msg":"trace[1538959897] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"104.118551ms","start":"2026-04-08T05:55:16.769964Z","end":"2026-04-08T05:55:16.874082Z","steps":["trace[1538959897] 'process raft request'  (duration: 103.980788ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:55:29.069359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.251389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T05:55:29.069476Z","caller":"traceutil/trace.go:171","msg":"trace[141071934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5204; }","duration":"145.452693ms","start":"2026-04-08T05:55:28.923998Z","end":"2026-04-08T05:55:29.069451Z","steps":["trace[141071934] 'range keys from in-memory index tree'  (duration: 145.106557ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T05:55:29.069615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.547074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mcxgh.18a44bff6c982a2b\" ","response":"range_response_count:1 size:906"}
{"level":"info","ts":"2026-04-08T05:55:29.069719Z","caller":"traceutil/trace.go:171","msg":"trace[107887120] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mcxgh.18a44bff6c982a2b; range_end:; response_count:1; response_revision:5204; }","duration":"162.669777ms","start":"2026-04-08T05:55:28.907029Z","end":"2026-04-08T05:55:29.069699Z","steps":["trace[107887120] 'range keys from in-memory index tree'  (duration: 162.370421ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:55:29.069805Z","caller":"traceutil/trace.go:171","msg":"trace[165054502] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"114.71871ms","start":"2026-04-08T05:55:28.955035Z","end":"2026-04-08T05:55:29.069753Z","steps":["trace[165054502] 'process raft request'  (duration: 114.349502ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:55:37.34304Z","caller":"traceutil/trace.go:171","msg":"trace[640043264] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"245.641843ms","start":"2026-04-08T05:55:37.09734Z","end":"2026-04-08T05:55:37.342982Z","steps":["trace[640043264] 'process raft request'  (duration: 245.48921ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:55:37.36975Z","caller":"traceutil/trace.go:171","msg":"trace[103234718] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"266.813346ms","start":"2026-04-08T05:55:37.102887Z","end":"2026-04-08T05:55:37.3697Z","steps":["trace[103234718] 'process raft request'  (duration: 266.681443ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:55:37.451602Z","caller":"traceutil/trace.go:171","msg":"trace[20943366] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"100.726111ms","start":"2026-04-08T05:55:37.350843Z","end":"2026-04-08T05:55:37.451569Z","steps":["trace[20943366] 'process raft request'  (duration: 86.704511ms)","trace[20943366] 'compare'  (duration: 13.821926ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T05:55:37.451687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.477353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-04-08T05:55:37.451801Z","caller":"traceutil/trace.go:171","msg":"trace[860922288] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5379; }","duration":"145.622136ms","start":"2026-04-08T05:55:37.306135Z","end":"2026-04-08T05:55:37.451757Z","steps":["trace[860922288] 'agreement among raft nodes before linearized reading'  (duration: 145.372711ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T05:55:37.624785Z","caller":"traceutil/trace.go:171","msg":"trace[1817318070] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"112.632007ms","start":"2026-04-08T05:55:37.512115Z","end":"2026-04-08T05:55:37.624747Z","steps":["trace[1817318070] 'process raft request'  (duration: 68.329833ms)","trace[1817318070] 'compare'  (duration: 44.151951ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T05:56:59.299552Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3014}
{"level":"info","ts":"2026-04-08T05:56:59.387869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3014,"took":"86.354486ms","hash":2142318906,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":31940608,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-04-08T05:56:59.387936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2142318906,"revision":3014,"compact-revision":-1}
{"level":"warn","ts":"2026-04-08T06:01:42.228874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.200531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:01:42.228977Z","caller":"traceutil/trace.go:171","msg":"trace[923501941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8201; }","duration":"306.378564ms","start":"2026-04-08T06:01:41.922578Z","end":"2026-04-08T06:01:42.228957Z","steps":["trace[923501941] 'range keys from in-memory index tree'  (duration: 306.056618ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:01:42.229024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:01:41.922555Z","time spent":"306.458355ms","remote":"127.0.0.1:37366","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-08T06:01:42.22935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.323269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-08T06:01:42.229336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.581806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b4mpd\" ","response":"range_response_count:1 size:6451"}
{"level":"info","ts":"2026-04-08T06:01:42.229412Z","caller":"traceutil/trace.go:171","msg":"trace[137950554] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8201; }","duration":"159.466603ms","start":"2026-04-08T06:01:42.069931Z","end":"2026-04-08T06:01:42.229397Z","steps":["trace[137950554] 'count revisions from in-memory index tree'  (duration: 159.195417ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:01:42.229468Z","caller":"traceutil/trace.go:171","msg":"trace[1001531952] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b4mpd; range_end:; response_count:1; response_revision:8201; }","duration":"115.77901ms","start":"2026-04-08T06:01:42.113651Z","end":"2026-04-08T06:01:42.22943Z","steps":["trace[1001531952] 'range keys from in-memory index tree'  (duration: 115.326631ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:01:53.846412Z","caller":"traceutil/trace.go:171","msg":"trace[338220547] linearizableReadLoop","detail":"{readStateIndex:8548; appliedIndex:8547; }","duration":"285.319637ms","start":"2026-04-08T06:01:53.561056Z","end":"2026-04-08T06:01:53.846376Z","steps":["trace[338220547] 'read index received'  (duration: 285.250395ms)","trace[338220547] 'applied index is now lower than readState.Index'  (duration: 67.822µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:01:53.846557Z","caller":"traceutil/trace.go:171","msg":"trace[1722832645] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"289.158142ms","start":"2026-04-08T06:01:53.557348Z","end":"2026-04-08T06:01:53.846506Z","steps":["trace[1722832645] 'process raft request'  (duration: 288.813046ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:01:53.846654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.570231ms","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-04-08T06:01:53.846697Z","caller":"traceutil/trace.go:171","msg":"trace[70495228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8260; }","duration":"285.668304ms","start":"2026-04-08T06:01:53.561019Z","end":"2026-04-08T06:01:53.846687Z","steps":["trace[70495228] 'agreement among raft nodes before linearized reading'  (duration: 285.49085ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:01:53.860756Z","caller":"traceutil/trace.go:171","msg":"trace[1760437669] transaction","detail":"{read_only:false; response_revision:8261; number_of_response:1; }","duration":"212.455132ms","start":"2026-04-08T06:01:53.64827Z","end":"2026-04-08T06:01:53.860726Z","steps":["trace[1760437669] 'process raft request'  (duration: 212.33083ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:01:54.687259Z","caller":"traceutil/trace.go:171","msg":"trace[269969539] transaction","detail":"{read_only:false; response_revision:8264; number_of_response:1; }","duration":"224.592521ms","start":"2026-04-08T06:01:54.462633Z","end":"2026-04-08T06:01:54.687225Z","steps":["trace[269969539] 'process raft request'  (duration: 224.297726ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:01:55.469267Z","caller":"traceutil/trace.go:171","msg":"trace[1951522192] transaction","detail":"{read_only:false; response_revision:8269; number_of_response:1; }","duration":"109.494106ms","start":"2026-04-08T06:01:55.359727Z","end":"2026-04-08T06:01:55.469221Z","steps":["trace[1951522192] 'process raft request'  (duration: 109.317982ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:01:55.619659Z","caller":"traceutil/trace.go:171","msg":"trace[1550781869] transaction","detail":"{read_only:false; response_revision:8270; number_of_response:1; }","duration":"109.803542ms","start":"2026-04-08T06:01:55.509819Z","end":"2026-04-08T06:01:55.619623Z","steps":["trace[1550781869] 'process raft request'  (duration: 42.290802ms)","trace[1550781869] 'compare'  (duration: 67.269555ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:01:59.307624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6122}
{"level":"info","ts":"2026-04-08T06:01:59.403324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6122,"took":"93.090292ms","hash":3146675386,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":23220224,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-04-08T06:01:59.403418Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3146675386,"revision":6122,"compact-revision":3014}
{"level":"warn","ts":"2026-04-08T06:02:36.349278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.984328ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975073138 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8562 > 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-04-08T06:02:36.349446Z","caller":"traceutil/trace.go:171","msg":"trace[974831551] transaction","detail":"{read_only:false; response_revision:8585; number_of_response:1; }","duration":"200.736541ms","start":"2026-04-08T06:02:36.148684Z","end":"2026-04-08T06:02:36.349421Z","steps":["trace[974831551] 'process raft request'  (duration: 66.507719ms)","trace[974831551] 'compare'  (duration: 133.803504ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:02:57.965317Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023bc.wal"}
{"level":"info","ts":"2026-04-08T06:04:38.87416Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T06:04:38.880156Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-08T06:04:38.880235Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-08T06:06:59.314424Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8296}
{"level":"info","ts":"2026-04-08T06:06:59.39457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8296,"took":"77.491261ms","hash":2836783661,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":25489408,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-08T06:06:59.394649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2836783661,"revision":8296,"compact-revision":6122}
{"level":"info","ts":"2026-04-08T06:07:40.053694Z","caller":"traceutil/trace.go:171","msg":"trace[1561567852] linearizableReadLoop","detail":"{readStateIndex:11583; appliedIndex:11581; }","duration":"162.886563ms","start":"2026-04-08T06:07:39.890767Z","end":"2026-04-08T06:07:40.053654Z","steps":["trace[1561567852] 'read index received'  (duration: 72.446109ms)","trace[1561567852] 'applied index is now lower than readState.Index'  (duration: 90.439064ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:07:40.053882Z","caller":"traceutil/trace.go:171","msg":"trace[1415009417] transaction","detail":"{read_only:false; response_revision:11205; number_of_response:1; }","duration":"167.135919ms","start":"2026-04-08T06:07:39.886715Z","end":"2026-04-08T06:07:40.053851Z","steps":["trace[1415009417] 'process raft request'  (duration: 100.521859ms)","trace[1415009417] 'compare'  (duration: 66.242763ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:07:40.054239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.068854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:07:40.054275Z","caller":"traceutil/trace.go:171","msg":"trace[1120078389] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11205; }","duration":"148.154145ms","start":"2026-04-08T06:07:39.906111Z","end":"2026-04-08T06:07:40.054265Z","steps":["trace[1120078389] 'agreement among raft nodes before linearized reading'  (duration: 148.074603ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:07:40.054323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.485787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:07:40.054421Z","caller":"traceutil/trace.go:171","msg":"trace[276362837] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11205; }","duration":"163.65198ms","start":"2026-04-08T06:07:39.890718Z","end":"2026-04-08T06:07:40.05437Z","steps":["trace[276362837] 'agreement among raft nodes before linearized reading'  (duration: 163.24169ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:07:40.054708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.460851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:07:40.054825Z","caller":"traceutil/trace.go:171","msg":"trace[2002602063] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11205; }","duration":"148.641264ms","start":"2026-04-08T06:07:39.906158Z","end":"2026-04-08T06:07:40.054799Z","steps":["trace[2002602063] 'agreement among raft nodes before linearized reading'  (duration: 148.44854ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:07:40.054975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.647395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5004"}
{"level":"warn","ts":"2026-04-08T06:07:40.055028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.076614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:07:40.055079Z","caller":"traceutil/trace.go:171","msg":"trace[755019330] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11205; }","duration":"146.812008ms","start":"2026-04-08T06:07:39.908241Z","end":"2026-04-08T06:07:40.055053Z","steps":["trace[755019330] 'agreement among raft nodes before linearized reading'  (duration: 146.347559ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:07:40.055122Z","caller":"traceutil/trace.go:171","msg":"trace[1645372287] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11205; }","duration":"148.460411ms","start":"2026-04-08T06:07:39.906639Z","end":"2026-04-08T06:07:40.0551Z","steps":["trace[1645372287] 'agreement among raft nodes before linearized reading'  (duration: 148.045093ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:11:59.321204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10793}
{"level":"info","ts":"2026-04-08T06:11:59.402772Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10793,"took":"78.334176ms","hash":3020789727,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":27881472,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-04-08T06:11:59.402846Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3020789727,"revision":10793,"compact-revision":8296}
{"level":"info","ts":"2026-04-08T06:13:31.834274Z","caller":"traceutil/trace.go:171","msg":"trace[259638899] transaction","detail":"{read_only:false; response_revision:13604; number_of_response:1; }","duration":"112.015385ms","start":"2026-04-08T06:13:31.722231Z","end":"2026-04-08T06:13:31.834246Z","steps":["trace[259638899] 'process raft request'  (duration: 111.830491ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:14:18.920129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.78449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:14:18.920251Z","caller":"traceutil/trace.go:171","msg":"trace[600971386] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:13868; }","duration":"184.004184ms","start":"2026-04-08T06:14:18.73622Z","end":"2026-04-08T06:14:18.920224Z","steps":["trace[600971386] 'count revisions from in-memory index tree'  (duration: 183.681197ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:14:41.725989Z","caller":"traceutil/trace.go:171","msg":"trace[1687392600] transaction","detail":"{read_only:false; response_revision:14181; number_of_response:1; }","duration":"295.507769ms","start":"2026-04-08T06:14:41.430444Z","end":"2026-04-08T06:14:41.725952Z","steps":["trace[1687392600] 'process raft request'  (duration: 295.296135ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:15:58.544915Z","caller":"traceutil/trace.go:171","msg":"trace[503857637] linearizableReadLoop","detail":"{readStateIndex:15448; appliedIndex:15447; }","duration":"122.54844ms","start":"2026-04-08T06:15:58.422329Z","end":"2026-04-08T06:15:58.544878Z","steps":["trace[503857637] 'read index received'  (duration: 122.279785ms)","trace[503857637] 'applied index is now lower than readState.Index'  (duration: 267.025µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:15:58.545118Z","caller":"traceutil/trace.go:171","msg":"trace[1747341832] transaction","detail":"{read_only:false; response_revision:14940; number_of_response:1; }","duration":"128.878864ms","start":"2026-04-08T06:15:58.416208Z","end":"2026-04-08T06:15:58.545087Z","steps":["trace[1747341832] 'process raft request'  (duration: 128.430855ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:15:58.545246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.869806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-04-08T06:15:58.545315Z","caller":"traceutil/trace.go:171","msg":"trace[1417443488] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14940; }","duration":"123.000078ms","start":"2026-04-08T06:15:58.422298Z","end":"2026-04-08T06:15:58.545298Z","steps":["trace[1417443488] 'agreement among raft nodes before linearized reading'  (duration: 122.735233ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:15:58.547758Z","caller":"traceutil/trace.go:171","msg":"trace[1190061111] transaction","detail":"{read_only:false; response_revision:14941; number_of_response:1; }","duration":"119.59479ms","start":"2026-04-08T06:15:58.428141Z","end":"2026-04-08T06:15:58.547736Z","steps":["trace[1190061111] 'process raft request'  (duration: 119.350905ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:15:59.628434Z","caller":"traceutil/trace.go:171","msg":"trace[897834116] linearizableReadLoop","detail":"{readStateIndex:15454; appliedIndex:15453; }","duration":"224.154594ms","start":"2026-04-08T06:15:59.404253Z","end":"2026-04-08T06:15:59.628407Z","steps":["trace[897834116] 'read index received'  (duration: 223.999991ms)","trace[897834116] 'applied index is now lower than readState.Index'  (duration: 153.443µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:15:59.628623Z","caller":"traceutil/trace.go:171","msg":"trace[27038217] transaction","detail":"{read_only:false; response_revision:14946; number_of_response:1; }","duration":"253.976853ms","start":"2026-04-08T06:15:59.37459Z","end":"2026-04-08T06:15:59.628567Z","steps":["trace[27038217] 'process raft request'  (duration: 253.653887ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:15:59.628743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.410289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:15:59.628815Z","caller":"traceutil/trace.go:171","msg":"trace[527220372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:14946; }","duration":"224.580242ms","start":"2026-04-08T06:15:59.404217Z","end":"2026-04-08T06:15:59.628797Z","steps":["trace[527220372] 'agreement among raft nodes before linearized reading'  (duration: 224.403728ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:15:59.628787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.223942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T06:15:59.629169Z","caller":"traceutil/trace.go:171","msg":"trace[876335420] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:14946; }","duration":"201.607769ms","start":"2026-04-08T06:15:59.427514Z","end":"2026-04-08T06:15:59.629122Z","steps":["trace[876335420] 'agreement among raft nodes before linearized reading'  (duration: 201.204061ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:15:59.629326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.12624ms","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-04-08T06:15:59.629373Z","caller":"traceutil/trace.go:171","msg":"trace[113431848] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14946; }","duration":"197.187922ms","start":"2026-04-08T06:15:59.432172Z","end":"2026-04-08T06:15:59.62936Z","steps":["trace[113431848] 'agreement among raft nodes before linearized reading'  (duration: 197.046559ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:15:59.629384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.866964ms","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-08T06:15:59.629366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.445676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"}
{"level":"info","ts":"2026-04-08T06:15:59.629439Z","caller":"traceutil/trace.go:171","msg":"trace[1696769485] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14946; }","duration":"126.949736ms","start":"2026-04-08T06:15:59.50247Z","end":"2026-04-08T06:15:59.62942Z","steps":["trace[1696769485] 'agreement among raft nodes before linearized reading'  (duration: 126.712591ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:15:59.629457Z","caller":"traceutil/trace.go:171","msg":"trace[420009670] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:14946; }","duration":"201.573138ms","start":"2026-04-08T06:15:59.427862Z","end":"2026-04-08T06:15:59.629435Z","steps":["trace[420009670] 'agreement among raft nodes before linearized reading'  (duration: 201.298533ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:15:59.629761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.053498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T06:15:59.629824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.242692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-04-08T06:15:59.629867Z","caller":"traceutil/trace.go:171","msg":"trace[872000095] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14946; }","duration":"202.340364ms","start":"2026-04-08T06:15:59.427516Z","end":"2026-04-08T06:15:59.629856Z","steps":["trace[872000095] 'agreement among raft nodes before linearized reading'  (duration: 202.225931ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:15:59.629877Z","caller":"traceutil/trace.go:171","msg":"trace[1893047036] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14946; }","duration":"202.253832ms","start":"2026-04-08T06:15:59.427598Z","end":"2026-04-08T06:15:59.629852Z","steps":["trace[1893047036] 'agreement among raft nodes before linearized reading'  (duration: 202.048648ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:16:59.327694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12971}
{"level":"info","ts":"2026-04-08T06:16:59.406736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12971,"took":"75.660803ms","hash":3243790645,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":30253056,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-04-08T06:16:59.406818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3243790645,"revision":12971,"compact-revision":10793}
{"level":"info","ts":"2026-04-08T06:21:55.754833Z","caller":"traceutil/trace.go:171","msg":"trace[1564869448] transaction","detail":"{read_only:false; response_revision:17570; number_of_response:1; }","duration":"134.947776ms","start":"2026-04-08T06:21:55.619846Z","end":"2026-04-08T06:21:55.754794Z","steps":["trace[1564869448] 'process raft request'  (duration: 133.972478ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:21:56.033802Z","caller":"traceutil/trace.go:171","msg":"trace[1933946088] transaction","detail":"{read_only:false; response_revision:17571; number_of_response:1; }","duration":"225.082982ms","start":"2026-04-08T06:21:55.808688Z","end":"2026-04-08T06:21:56.033771Z","steps":["trace[1933946088] 'process raft request'  (duration: 224.896488ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:21:56.063099Z","caller":"traceutil/trace.go:171","msg":"trace[216248250] transaction","detail":"{read_only:false; response_revision:17573; number_of_response:1; }","duration":"150.654566ms","start":"2026-04-08T06:21:55.912411Z","end":"2026-04-08T06:21:56.063066Z","steps":["trace[216248250] 'process raft request'  (duration: 150.602075ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:21:56.063589Z","caller":"traceutil/trace.go:171","msg":"trace[882506054] transaction","detail":"{read_only:false; response_revision:17572; number_of_response:1; }","duration":"155.936989ms","start":"2026-04-08T06:21:55.907639Z","end":"2026-04-08T06:21:56.063576Z","steps":["trace[882506054] 'process raft request'  (duration: 155.247575ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:21:59.333871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15319}
{"level":"info","ts":"2026-04-08T06:21:59.426367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15319,"took":"88.976642ms","hash":2491876292,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":31772672,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-04-08T06:21:59.426448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2491876292,"revision":15319,"compact-revision":12971}
{"level":"info","ts":"2026-04-08T06:25:29.294166Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T06:25:29.300706Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-04-08T06:25:29.300824Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-04-08T06:26:59.340345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17604}
{"level":"info","ts":"2026-04-08T06:26:59.445761Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17604,"took":"100.320934ms","hash":3214088482,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":33898496,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-08T06:26:59.44584Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3214088482,"revision":17604,"compact-revision":15319}
{"level":"info","ts":"2026-04-08T06:27:37.507869Z","caller":"traceutil/trace.go:171","msg":"trace[1712203670] transaction","detail":"{read_only:false; response_revision:20233; number_of_response:1; }","duration":"135.349262ms","start":"2026-04-08T06:27:37.372487Z","end":"2026-04-08T06:27:37.507837Z","steps":["trace[1712203670] 'process raft request'  (duration: 135.120648ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:27:37.508538Z","caller":"traceutil/trace.go:171","msg":"trace[25705244] transaction","detail":"{read_only:false; response_revision:20235; number_of_response:1; }","duration":"125.448896ms","start":"2026-04-08T06:27:37.38306Z","end":"2026-04-08T06:27:37.508509Z","steps":["trace[25705244] 'process raft request'  (duration: 125.378655ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:27:37.508703Z","caller":"traceutil/trace.go:171","msg":"trace[1410387604] transaction","detail":"{read_only:false; response_revision:20234; number_of_response:1; }","duration":"135.821952ms","start":"2026-04-08T06:27:37.372754Z","end":"2026-04-08T06:27:37.508576Z","steps":["trace[1410387604] 'process raft request'  (duration: 135.533325ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:27:43.667377Z","caller":"traceutil/trace.go:171","msg":"trace[1199028214] linearizableReadLoop","detail":"{readStateIndex:20952; appliedIndex:20950; }","duration":"136.684069ms","start":"2026-04-08T06:27:43.530657Z","end":"2026-04-08T06:27:43.667342Z","steps":["trace[1199028214] 'read index received'  (duration: 6.689433ms)","trace[1199028214] 'applied index is now lower than readState.Index'  (duration: 129.993716ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:27:43.667437Z","caller":"traceutil/trace.go:171","msg":"trace[1967132456] transaction","detail":"{read_only:false; response_revision:20266; number_of_response:1; }","duration":"139.103656ms","start":"2026-04-08T06:27:43.528289Z","end":"2026-04-08T06:27:43.667392Z","steps":["trace[1967132456] 'process raft request'  (duration: 138.828291ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:27:43.667469Z","caller":"traceutil/trace.go:171","msg":"trace[1910646103] transaction","detail":"{read_only:false; response_revision:20267; number_of_response:1; }","duration":"136.22426ms","start":"2026-04-08T06:27:43.531202Z","end":"2026-04-08T06:27:43.667427Z","steps":["trace[1910646103] 'process raft request'  (duration: 136.090517ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:27:43.667638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.951724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:27:43.667696Z","caller":"traceutil/trace.go:171","msg":"trace[1416269877] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:20267; }","duration":"137.084746ms","start":"2026-04-08T06:27:43.530593Z","end":"2026-04-08T06:27:43.667678Z","steps":["trace[1416269877] 'agreement among raft nodes before linearized reading'  (duration: 136.973274ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:27:43.804233Z","caller":"traceutil/trace.go:171","msg":"trace[1369653911] transaction","detail":"{read_only:false; response_revision:20268; number_of_response:1; }","duration":"131.766487ms","start":"2026-04-08T06:27:43.672421Z","end":"2026-04-08T06:27:43.804188Z","steps":["trace[1369653911] 'process raft request'  (duration: 117.451103ms)","trace[1369653911] 'compare'  (duration: 14.11365ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:27:44.078493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.159639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"}
{"level":"info","ts":"2026-04-08T06:27:44.078606Z","caller":"traceutil/trace.go:171","msg":"trace[542818214] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:20268; }","duration":"116.353583ms","start":"2026-04-08T06:27:43.96222Z","end":"2026-04-08T06:27:44.078573Z","steps":["trace[542818214] 'range keys from in-memory index tree'  (duration: 115.899824ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:31:37.37808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.631147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-04-08T06:31:37.378121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.745759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:31:37.378192Z","caller":"traceutil/trace.go:171","msg":"trace[110509766] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22688; }","duration":"116.812861ms","start":"2026-04-08T06:31:37.261359Z","end":"2026-04-08T06:31:37.378172Z","steps":["trace[110509766] 'range keys from in-memory index tree'  (duration: 116.420633ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:31:37.37824Z","caller":"traceutil/trace.go:171","msg":"trace[1038375987] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:22688; }","duration":"124.935232ms","start":"2026-04-08T06:31:37.253278Z","end":"2026-04-08T06:31:37.378214Z","steps":["trace[1038375987] 'count revisions from in-memory index tree'  (duration: 124.651187ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:31:37.751877Z","caller":"traceutil/trace.go:171","msg":"trace[395084310] linearizableReadLoop","detail":"{readStateIndex:23447; appliedIndex:23446; }","duration":"292.763619ms","start":"2026-04-08T06:31:37.459078Z","end":"2026-04-08T06:31:37.751841Z","steps":["trace[395084310] 'read index received'  (duration: 292.397792ms)","trace[395084310] 'applied index is now lower than readState.Index'  (duration: 364.237µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:31:37.752009Z","caller":"traceutil/trace.go:171","msg":"trace[1670046019] transaction","detail":"{read_only:false; response_revision:22689; number_of_response:1; }","duration":"308.96841ms","start":"2026-04-08T06:31:37.442987Z","end":"2026-04-08T06:31:37.751956Z","steps":["trace[1670046019] 'process raft request'  (duration: 308.640004ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:31:37.75223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.108116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-08T06:31:37.752306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.455111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-04-08T06:31:37.752301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:31:37.442956Z","time spent":"309.199625ms","remote":"127.0.0.1:37686","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:22661 > 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-08T06:31:37.752365Z","caller":"traceutil/trace.go:171","msg":"trace[827367044] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:22689; }","duration":"293.304409ms","start":"2026-04-08T06:31:37.459026Z","end":"2026-04-08T06:31:37.752331Z","steps":["trace[827367044] 'agreement among raft nodes before linearized reading'  (duration: 292.952453ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:31:37.752375Z","caller":"traceutil/trace.go:171","msg":"trace[775992075] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22689; }","duration":"231.613534ms","start":"2026-04-08T06:31:37.520745Z","end":"2026-04-08T06:31:37.752359Z","steps":["trace[775992075] 'agreement among raft nodes before linearized reading'  (duration: 231.334409ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:31:37.752703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.566913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-08T06:31:37.75274Z","caller":"traceutil/trace.go:171","msg":"trace[1631094997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22689; }","duration":"222.605014ms","start":"2026-04-08T06:31:37.530122Z","end":"2026-04-08T06:31:37.752727Z","steps":["trace[1631094997] 'agreement among raft nodes before linearized reading'  (duration: 222.471522ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:31:37.753778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.61917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-08T06:31:37.753942Z","caller":"traceutil/trace.go:171","msg":"trace[37884074] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:22689; }","duration":"188.861234ms","start":"2026-04-08T06:31:37.56505Z","end":"2026-04-08T06:31:37.753911Z","steps":["trace[37884074] 'agreement among raft nodes before linearized reading'  (duration: 187.099069ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:31:59.347408Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20040}
{"level":"info","ts":"2026-04-08T06:31:59.460665Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20040,"took":"108.575858ms","hash":2712938593,"current-db-size-bytes":59162624,"current-db-size":"59 MB","current-db-size-in-use-bytes":39731200,"current-db-size-in-use":"40 MB"}
{"level":"info","ts":"2026-04-08T06:31:59.460758Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2712938593,"revision":20040,"compact-revision":17604}
{"level":"warn","ts":"2026-04-08T06:34:53.09775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.607766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:34:53.097877Z","caller":"traceutil/trace.go:171","msg":"trace[414463074] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24692; }","duration":"203.745158ms","start":"2026-04-08T06:34:52.894092Z","end":"2026-04-08T06:34:53.097837Z","steps":["trace[414463074] 'count revisions from in-memory index tree'  (duration: 203.478913ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:53.227392Z","caller":"traceutil/trace.go:171","msg":"trace[1159765749] transaction","detail":"{read_only:false; response_revision:24693; number_of_response:1; }","duration":"122.936083ms","start":"2026-04-08T06:34:53.10442Z","end":"2026-04-08T06:34:53.227356Z","steps":["trace[1159765749] 'process raft request'  (duration: 122.717718ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:53.487461Z","caller":"traceutil/trace.go:171","msg":"trace[467089303] transaction","detail":"{read_only:false; response_revision:24694; number_of_response:1; }","duration":"382.978901ms","start":"2026-04-08T06:34:53.104446Z","end":"2026-04-08T06:34:53.487425Z","steps":["trace[467089303] 'process raft request'  (duration: 382.496632ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:34:53.487704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:53.10442Z","time spent":"383.160394ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24679 > 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":"info","ts":"2026-04-08T06:34:53.591238Z","caller":"traceutil/trace.go:171","msg":"trace[1908674310] transaction","detail":"{read_only:false; response_revision:24695; number_of_response:1; }","duration":"319.328407ms","start":"2026-04-08T06:34:53.27186Z","end":"2026-04-08T06:34:53.591188Z","steps":["trace[1908674310] 'process raft request'  (duration: 256.296155ms)","trace[1908674310] 'compare'  (duration: 62.518192ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:34:53.591278Z","caller":"traceutil/trace.go:171","msg":"trace[273439224] transaction","detail":"{read_only:false; response_revision:24697; number_of_response:1; }","duration":"184.806834ms","start":"2026-04-08T06:34:53.406433Z","end":"2026-04-08T06:34:53.59124Z","steps":["trace[273439224] 'process raft request'  (duration: 184.676741ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:53.59142Z","caller":"traceutil/trace.go:171","msg":"trace[441346710] linearizableReadLoop","detail":"{readStateIndex:25507; appliedIndex:25504; }","duration":"254.694432ms","start":"2026-04-08T06:34:53.336695Z","end":"2026-04-08T06:34:53.59139Z","steps":["trace[441346710] 'read index received'  (duration: 150.255926ms)","trace[441346710] 'applied index is now lower than readState.Index'  (duration: 104.437476ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:34:53.591474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:53.271836Z","time spent":"319.515551ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"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:24627 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:516 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-08T06:34:53.591563Z","caller":"traceutil/trace.go:171","msg":"trace[1757633657] transaction","detail":"{read_only:false; response_revision:24696; number_of_response:1; }","duration":"317.612424ms","start":"2026-04-08T06:34:53.273896Z","end":"2026-04-08T06:34:53.591508Z","steps":["trace[1757633657] 'process raft request'  (duration: 317.086753ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:34:53.591705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.993768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-08T06:34:53.591775Z","caller":"traceutil/trace.go:171","msg":"trace[698034840] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:24698; }","duration":"255.1063ms","start":"2026-04-08T06:34:53.336631Z","end":"2026-04-08T06:34:53.591737Z","steps":["trace[698034840] 'agreement among raft nodes before linearized reading'  (duration: 254.861826ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:34:53.591843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:53.27388Z","time spent":"317.811367ms","remote":"127.0.0.1:37686","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:24681 > 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-04-08T06:34:53.59193Z","caller":"traceutil/trace.go:171","msg":"trace[273236472] transaction","detail":"{read_only:false; response_revision:24698; number_of_response:1; }","duration":"171.797645ms","start":"2026-04-08T06:34:53.420118Z","end":"2026-04-08T06:34:53.591916Z","steps":["trace[273236472] 'process raft request'  (duration: 171.07221ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:53.823814Z","caller":"traceutil/trace.go:171","msg":"trace[2073497660] transaction","detail":"{read_only:false; response_revision:24699; number_of_response:1; }","duration":"216.784149ms","start":"2026-04-08T06:34:53.607Z","end":"2026-04-08T06:34:53.823785Z","steps":["trace[2073497660] 'process raft request'  (duration: 125.407573ms)","trace[2073497660] 'compare'  (duration: 91.266923ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:34:54.094242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.635642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:34:54.094337Z","caller":"traceutil/trace.go:171","msg":"trace[1821715444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24699; }","duration":"170.772434ms","start":"2026-04-08T06:34:53.92354Z","end":"2026-04-08T06:34:54.094312Z","steps":["trace[1821715444] 'range keys from in-memory index tree'  (duration: 170.56429ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:54.095501Z","caller":"traceutil/trace.go:171","msg":"trace[1922594761] transaction","detail":"{read_only:false; response_revision:24700; number_of_response:1; }","duration":"126.909042ms","start":"2026-04-08T06:34:53.968577Z","end":"2026-04-08T06:34:54.095486Z","steps":["trace[1922594761] 'process raft request'  (duration: 126.276239ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:54.551136Z","caller":"traceutil/trace.go:171","msg":"trace[1929042713] linearizableReadLoop","detail":"{readStateIndex:25513; appliedIndex:25512; }","duration":"127.408022ms","start":"2026-04-08T06:34:54.423697Z","end":"2026-04-08T06:34:54.551105Z","steps":["trace[1929042713] 'read index received'  (duration: 127.193548ms)","trace[1929042713] 'applied index is now lower than readState.Index'  (duration: 213.004µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:34:54.551337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.615726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:34:54.551388Z","caller":"traceutil/trace.go:171","msg":"trace[666652714] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:24702; }","duration":"127.753469ms","start":"2026-04-08T06:34:54.42362Z","end":"2026-04-08T06:34:54.551373Z","steps":["trace[666652714] 'agreement among raft nodes before linearized reading'  (duration: 127.602436ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:34:54.55184Z","caller":"traceutil/trace.go:171","msg":"trace[2138699548] transaction","detail":"{read_only:false; response_revision:24702; number_of_response:1; }","duration":"164.898578ms","start":"2026-04-08T06:34:54.386928Z","end":"2026-04-08T06:34:54.551827Z","steps":["trace[2138699548] 'process raft request'  (duration: 163.96794ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:00.407419Z","caller":"traceutil/trace.go:171","msg":"trace[777828187] transaction","detail":"{read_only:false; response_revision:24753; number_of_response:1; }","duration":"301.223748ms","start":"2026-04-08T06:35:00.106169Z","end":"2026-04-08T06:35:00.407393Z","steps":["trace[777828187] 'process raft request'  (duration: 301.077055ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:00.407458Z","caller":"traceutil/trace.go:171","msg":"trace[1776169301] linearizableReadLoop","detail":"{readStateIndex:25565; appliedIndex:25565; }","duration":"298.162666ms","start":"2026-04-08T06:35:00.109255Z","end":"2026-04-08T06:35:00.407418Z","steps":["trace[1776169301] 'read index received'  (duration: 298.146856ms)","trace[1776169301] 'applied index is now lower than readState.Index'  (duration: 12.52µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:00.407556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.106125Z","time spent":"301.36899ms","remote":"127.0.0.1:37658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5342,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/heat-engine-cleaner-29593835\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29593835\" value_size:5281 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T06:35:00.407748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.474213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:00.407809Z","caller":"traceutil/trace.go:171","msg":"trace[867317372] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:24753; }","duration":"298.548925ms","start":"2026-04-08T06:35:00.109237Z","end":"2026-04-08T06:35:00.407786Z","steps":["trace[867317372] 'agreement among raft nodes before linearized reading'  (duration: 298.360191ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:00.773404Z","caller":"traceutil/trace.go:171","msg":"trace[112218785] linearizableReadLoop","detail":"{readStateIndex:25566; appliedIndex:25565; }","duration":"365.82487ms","start":"2026-04-08T06:35:00.407549Z","end":"2026-04-08T06:35:00.773374Z","steps":["trace[112218785] 'read index received'  (duration: 365.719518ms)","trace[112218785] 'applied index is now lower than readState.Index'  (duration: 103.932µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:00.77347Z","caller":"traceutil/trace.go:171","msg":"trace[589761276] transaction","detail":"{read_only:false; response_revision:24754; number_of_response:1; }","duration":"658.974768ms","start":"2026-04-08T06:35:00.114476Z","end":"2026-04-08T06:35:00.77345Z","steps":["trace[589761276] 'process raft request'  (duration: 658.709283ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:00.77354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.575033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-08T06:35:00.773596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.114442Z","time spent":"659.076759ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24738 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-04-08T06:35:00.773618Z","caller":"traceutil/trace.go:171","msg":"trace[1086078269] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24754; }","duration":"387.725176ms","start":"2026-04-08T06:35:00.385876Z","end":"2026-04-08T06:35:00.773601Z","steps":["trace[1086078269] 'agreement among raft nodes before linearized reading'  (duration: 387.523912ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:00.773657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.385846Z","time spent":"387.801148ms","remote":"127.0.0.1:50746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T06:35:00.773668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.465207ms","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-04-08T06:35:00.773713Z","caller":"traceutil/trace.go:171","msg":"trace[1417378416] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24754; }","duration":"582.626741ms","start":"2026-04-08T06:35:00.191069Z","end":"2026-04-08T06:35:00.773696Z","steps":["trace[1417378416] 'agreement among raft nodes before linearized reading'  (duration: 582.458237ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:00.773665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.04148ms","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":"warn","ts":"2026-04-08T06:35:00.773757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.19104Z","time spent":"582.708822ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-08T06:35:00.773797Z","caller":"traceutil/trace.go:171","msg":"trace[440557145] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:24754; }","duration":"493.287344ms","start":"2026-04-08T06:35:00.28048Z","end":"2026-04-08T06:35:00.773768Z","steps":["trace[440557145] 'agreement among raft nodes before linearized reading'  (duration: 493.028259ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:00.773874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.280456Z","time spent":"493.402527ms","remote":"127.0.0.1:51632","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-04-08T06:35:01.03959Z","caller":"traceutil/trace.go:171","msg":"trace[1830690821] transaction","detail":"{read_only:false; response_revision:24755; number_of_response:1; }","duration":"626.433869ms","start":"2026-04-08T06:35:00.413116Z","end":"2026-04-08T06:35:01.03955Z","steps":["trace[1830690821] 'process raft request'  (duration: 626.100183ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.039754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.413079Z","time spent":"626.604823ms","remote":"127.0.0.1:37460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/heat-engine-cleaner.18a44e2b2b6c6370\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/heat-engine-cleaner.18a44e2b2b6c6370\" value_size:617 lease:3415871927975119863 >> failure:<>"}
{"level":"info","ts":"2026-04-08T06:35:01.039753Z","caller":"traceutil/trace.go:171","msg":"trace[1771218255] transaction","detail":"{read_only:false; response_revision:24756; number_of_response:1; }","duration":"622.082464ms","start":"2026-04-08T06:35:00.417619Z","end":"2026-04-08T06:35:01.039702Z","steps":["trace[1771218255] 'process raft request'  (duration: 621.815819ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.03996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.417587Z","time spent":"622.269097ms","remote":"127.0.0.1:37666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5447,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/cronjobs/openstack/heat-engine-cleaner\" mod_revision:21470 > success:<request_put:<key:\"/registry/cronjobs/openstack/heat-engine-cleaner\" value_size:5391 >> failure:<request_range:<key:\"/registry/cronjobs/openstack/heat-engine-cleaner\" > >"}
{"level":"info","ts":"2026-04-08T06:35:01.040137Z","caller":"traceutil/trace.go:171","msg":"trace[1038914277] transaction","detail":"{read_only:false; response_revision:24757; number_of_response:1; }","duration":"532.092014ms","start":"2026-04-08T06:35:00.50801Z","end":"2026-04-08T06:35:01.040102Z","steps":["trace[1038914277] 'process raft request'  (duration: 531.503603ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.040295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.507966Z","time spent":"532.253539ms","remote":"127.0.0.1:37460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" value_size:725 lease:3415871927975119863 >> failure:<>"}
{"level":"info","ts":"2026-04-08T06:35:01.040302Z","caller":"traceutil/trace.go:171","msg":"trace[1574376796] transaction","detail":"{read_only:false; response_revision:24758; number_of_response:1; }","duration":"468.045194ms","start":"2026-04-08T06:35:00.57223Z","end":"2026-04-08T06:35:01.040275Z","steps":["trace[1574376796] 'process raft request'  (duration: 467.735197ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:01.040354Z","caller":"traceutil/trace.go:171","msg":"trace[1851991405] transaction","detail":"{read_only:false; response_revision:24759; number_of_response:1; }","duration":"417.977458ms","start":"2026-04-08T06:35:00.622338Z","end":"2026-04-08T06:35:01.040315Z","steps":["trace[1851991405] 'process raft request'  (duration: 417.836195ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.040471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.572192Z","time spent":"468.186467ms","remote":"127.0.0.1:37686","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:24741 > 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-04-08T06:35:01.040551Z","caller":"traceutil/trace.go:171","msg":"trace[864868591] linearizableReadLoop","detail":"{readStateIndex:25571; appliedIndex:25566; }","duration":"267.023497ms","start":"2026-04-08T06:35:00.773493Z","end":"2026-04-08T06:35:01.040517Z","steps":["trace[864868591] 'read index received'  (duration: 265.759512ms)","trace[864868591] 'applied index is now lower than readState.Index'  (duration: 1.261175ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:01.040586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.622305Z","time spent":"418.138591ms","remote":"127.0.0.1:37686","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:24743 > 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-04-08T06:35:01.040668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.58168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:01.040716Z","caller":"traceutil/trace.go:171","msg":"trace[162553118] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24759; }","duration":"490.734574ms","start":"2026-04-08T06:35:00.549969Z","end":"2026-04-08T06:35:01.040703Z","steps":["trace[162553118] 'agreement among raft nodes before linearized reading'  (duration: 490.555871ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.04072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.932251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-08T06:35:01.040713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.397301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:01.040767Z","caller":"traceutil/trace.go:171","msg":"trace[1925924573] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:24759; }","duration":"626.033923ms","start":"2026-04-08T06:35:00.414722Z","end":"2026-04-08T06:35:01.040756Z","steps":["trace[1925924573] 'agreement among raft nodes before linearized reading'  (duration: 625.944981ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:01.040777Z","caller":"traceutil/trace.go:171","msg":"trace[949462475] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:24759; }","duration":"545.470152ms","start":"2026-04-08T06:35:00.495293Z","end":"2026-04-08T06:35:01.040763Z","steps":["trace[949462475] 'agreement among raft nodes before linearized reading'  (duration: 545.36741ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.040811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.414693Z","time spent":"626.110735ms","remote":"127.0.0.1:37550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" "}
{"level":"warn","ts":"2026-04-08T06:35:01.040813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.495197Z","time spent":"545.608184ms","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T06:35:01.040928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.067011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"warn","ts":"2026-04-08T06:35:01.040939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.549941Z","time spent":"490.814526ms","remote":"127.0.0.1:50508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true "}
{"level":"info","ts":"2026-04-08T06:35:01.040975Z","caller":"traceutil/trace.go:171","msg":"trace[434534540] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:24759; }","duration":"322.160153ms","start":"2026-04-08T06:35:00.718802Z","end":"2026-04-08T06:35:01.040963Z","steps":["trace[434534540] 'agreement among raft nodes before linearized reading'  (duration: 321.968719ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.04101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.718765Z","time spent":"322.237455ms","remote":"127.0.0.1:37454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"info","ts":"2026-04-08T06:35:01.227053Z","caller":"traceutil/trace.go:171","msg":"trace[1185684388] linearizableReadLoop","detail":"{readStateIndex:25573; appliedIndex:25571; }","duration":"186.439585ms","start":"2026-04-08T06:35:01.04059Z","end":"2026-04-08T06:35:01.22703Z","steps":["trace[1185684388] 'read index received'  (duration: 186.260381ms)","trace[1185684388] 'applied index is now lower than readState.Index'  (duration: 178.214µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:01.227153Z","caller":"traceutil/trace.go:171","msg":"trace[1957935388] transaction","detail":"{read_only:false; response_revision:24761; number_of_response:1; }","duration":"445.070436ms","start":"2026-04-08T06:35:00.782057Z","end":"2026-04-08T06:35:01.227127Z","steps":["trace[1957935388] 'process raft request'  (duration: 444.936093ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.227227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.630457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-04-08T06:35:01.227273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.332121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:131027"}
{"level":"info","ts":"2026-04-08T06:35:01.2273Z","caller":"traceutil/trace.go:171","msg":"trace[2118774877] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:24761; }","duration":"448.386642ms","start":"2026-04-08T06:35:00.778908Z","end":"2026-04-08T06:35:01.227295Z","steps":["trace[2118774877] 'agreement among raft nodes before linearized reading'  (duration: 448.231079ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:01.227296Z","caller":"traceutil/trace.go:171","msg":"trace[1058734628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24761; }","duration":"357.72968ms","start":"2026-04-08T06:35:00.869555Z","end":"2026-04-08T06:35:01.227285Z","steps":["trace[1058734628] 'agreement among raft nodes before linearized reading'  (duration: 357.514176ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.227316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.778887Z","time spent":"448.426063ms","remote":"127.0.0.1:37440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":131050,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-04-08T06:35:01.22733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.869539Z","time spent":"357.784491ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-08T06:35:01.227274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.782029Z","time spent":"445.158228ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"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:24744 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-08T06:35:01.227441Z","caller":"traceutil/trace.go:171","msg":"trace[1093786074] transaction","detail":"{read_only:false; response_revision:24760; number_of_response:1; }","duration":"446.188278ms","start":"2026-04-08T06:35:00.781208Z","end":"2026-04-08T06:35:01.227396Z","steps":["trace[1093786074] 'process raft request'  (duration: 445.643447ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.227609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.027655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-08T06:35:01.22764Z","caller":"traceutil/trace.go:171","msg":"trace[588652764] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24761; }","duration":"365.091796ms","start":"2026-04-08T06:35:00.862541Z","end":"2026-04-08T06:35:01.227633Z","steps":["trace[588652764] 'agreement among raft nodes before linearized reading'  (duration: 364.888462ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.227656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.862519Z","time spent":"365.133327ms","remote":"127.0.0.1:37686","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-04-08T06:35:01.227712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:00.781192Z","time spent":"446.352721ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24739 > 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\" > >"}
{"level":"info","ts":"2026-04-08T06:35:01.484322Z","caller":"traceutil/trace.go:171","msg":"trace[643368526] linearizableReadLoop","detail":"{readStateIndex:25574; appliedIndex:25573; }","duration":"257.170821ms","start":"2026-04-08T06:35:01.227122Z","end":"2026-04-08T06:35:01.484293Z","steps":["trace[643368526] 'read index received'  (duration: 257.002128ms)","trace[643368526] 'applied index is now lower than readState.Index'  (duration: 167.293µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:01.484432Z","caller":"traceutil/trace.go:171","msg":"trace[141454064] transaction","detail":"{read_only:false; response_revision:24762; number_of_response:1; }","duration":"440.000485ms","start":"2026-04-08T06:35:01.044381Z","end":"2026-04-08T06:35:01.484382Z","steps":["trace[141454064] 'process raft request'  (duration: 439.701719ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.484682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.044365Z","time spent":"440.198229ms","remote":"127.0.0.1:37608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5539,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm\" value_size:5472 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T06:35:01.484753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.967295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" ","response":"range_response_count:1 size:831"}
{"level":"info","ts":"2026-04-08T06:35:01.484835Z","caller":"traceutil/trace.go:171","msg":"trace[310887145] range","detail":"{range_begin:/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6; range_end:; response_count:1; response_revision:24762; }","duration":"440.082117ms","start":"2026-04-08T06:35:01.044733Z","end":"2026-04-08T06:35:01.484815Z","steps":["trace[310887145] 'agreement among raft nodes before linearized reading'  (duration: 439.640808ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.484868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.044724Z","time spent":"440.136167ms","remote":"127.0.0.1:37460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":854,"request content":"key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" "}
{"level":"warn","ts":"2026-04-08T06:35:01.484963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.724309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/openstack/heat-engine-cleaner\" ","response":"range_response_count:1 size:5465"}
{"level":"info","ts":"2026-04-08T06:35:01.485025Z","caller":"traceutil/trace.go:171","msg":"trace[1864127333] range","detail":"{range_begin:/registry/cronjobs/openstack/heat-engine-cleaner; range_end:; response_count:1; response_revision:24762; }","duration":"440.876262ms","start":"2026-04-08T06:35:01.044135Z","end":"2026-04-08T06:35:01.485011Z","steps":["trace[1864127333] 'agreement among raft nodes before linearized reading'  (duration: 440.306731ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.485073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.044119Z","time spent":"440.942743ms","remote":"127.0.0.1:37666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":5488,"request content":"key:\"/registry/cronjobs/openstack/heat-engine-cleaner\" "}
{"level":"warn","ts":"2026-04-08T06:35:01.485632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.824221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:89 size:117445"}
{"level":"info","ts":"2026-04-08T06:35:01.485682Z","caller":"traceutil/trace.go:171","msg":"trace[770269070] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:89; response_revision:24762; }","duration":"441.907863ms","start":"2026-04-08T06:35:01.043763Z","end":"2026-04-08T06:35:01.485671Z","steps":["trace[770269070] 'agreement among raft nodes before linearized reading'  (duration: 440.686348ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.485723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.043749Z","time spent":"441.961074ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":89,"response size":117468,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "}
{"level":"info","ts":"2026-04-08T06:35:01.732934Z","caller":"traceutil/trace.go:171","msg":"trace[442650457] transaction","detail":"{read_only:false; response_revision:24763; number_of_response:1; }","duration":"500.529429ms","start":"2026-04-08T06:35:01.232379Z","end":"2026-04-08T06:35:01.732908Z","steps":["trace[442650457] 'process raft request'  (duration: 431.323903ms)","trace[442650457] 'compare'  (duration: 68.885719ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:01.733068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.232362Z","time spent":"500.63679ms","remote":"127.0.0.1:37686","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:24745 > 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-04-08T06:35:01.733069Z","caller":"traceutil/trace.go:171","msg":"trace[1083500408] linearizableReadLoop","detail":"{readStateIndex:25576; appliedIndex:25574; }","duration":"248.629311ms","start":"2026-04-08T06:35:01.484416Z","end":"2026-04-08T06:35:01.733046Z","steps":["trace[1083500408] 'read index received'  (duration: 179.354444ms)","trace[1083500408] 'applied index is now lower than readState.Index'  (duration: 69.273367ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:01.733263Z","caller":"traceutil/trace.go:171","msg":"trace[1208176707] transaction","detail":"{read_only:false; response_revision:24764; number_of_response:1; }","duration":"500.12187ms","start":"2026-04-08T06:35:01.23312Z","end":"2026-04-08T06:35:01.733242Z","steps":["trace[1208176707] 'process raft request'  (duration: 499.731233ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.733352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.2331Z","time spent":"500.211743ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24746 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-08T06:35:01.733416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.94439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-08T06:35:01.733505Z","caller":"traceutil/trace.go:171","msg":"trace[1099436251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24764; }","duration":"472.092873ms","start":"2026-04-08T06:35:01.261392Z","end":"2026-04-08T06:35:01.733485Z","steps":["trace[1099436251] 'agreement among raft nodes before linearized reading'  (duration: 471.858798ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.733552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.26137Z","time spent":"472.172595ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-08T06:35:01.733678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.360245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:89 size:117445"}
{"level":"info","ts":"2026-04-08T06:35:01.733709Z","caller":"traceutil/trace.go:171","msg":"trace[1131543392] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:89; response_revision:24764; }","duration":"502.430535ms","start":"2026-04-08T06:35:01.231271Z","end":"2026-04-08T06:35:01.733702Z","steps":["trace[1131543392] 'agreement among raft nodes before linearized reading'  (duration: 501.982116ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:01.733729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.23125Z","time spent":"502.473457ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":89,"response size":117468,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "}
{"level":"info","ts":"2026-04-08T06:35:02.083442Z","caller":"traceutil/trace.go:171","msg":"trace[89222842] transaction","detail":"{read_only:false; response_revision:24765; number_of_response:1; }","duration":"596.276921ms","start":"2026-04-08T06:35:01.487121Z","end":"2026-04-08T06:35:02.083398Z","steps":["trace[89222842] 'process raft request'  (duration: 595.912214ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.083669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.487094Z","time spent":"596.443315ms","remote":"127.0.0.1:37460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" mod_revision:24757 > success:<request_put:<key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" value_size:725 lease:3415871927975119863 >> failure:<request_range:<key:\"/registry/events/openstack/magnum-api-69686785d-42sbf.18a44e2b3118f5a6\" > >"}
{"level":"info","ts":"2026-04-08T06:35:02.084191Z","caller":"traceutil/trace.go:171","msg":"trace[907302281] transaction","detail":"{read_only:false; response_revision:24766; number_of_response:1; }","duration":"593.412894ms","start":"2026-04-08T06:35:01.490728Z","end":"2026-04-08T06:35:02.084141Z","steps":["trace[907302281] 'process raft request'  (duration: 592.549888ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:02.084242Z","caller":"traceutil/trace.go:171","msg":"trace[1399061746] transaction","detail":"{read_only:false; response_revision:24767; number_of_response:1; }","duration":"593.352093ms","start":"2026-04-08T06:35:01.49087Z","end":"2026-04-08T06:35:02.084222Z","steps":["trace[1399061746] 'process raft request'  (duration: 593.147859ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.084321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.490864Z","time spent":"593.421334ms","remote":"127.0.0.1:37460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":720,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/heat-engine-cleaner-29593835.18a44e2b6ba30019\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/heat-engine-cleaner-29593835.18a44e2b6ba30019\" value_size:630 lease:3415871927975119863 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T06:35:02.084392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.490719Z","time spent":"593.565427ms","remote":"127.0.0.1:37608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5585,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm\" mod_revision:24762 > success:<request_put:<key:\"/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm\" value_size:5518 >> failure:<request_range:<key:\"/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm\" > >"}
{"level":"info","ts":"2026-04-08T06:35:02.085189Z","caller":"traceutil/trace.go:171","msg":"trace[1757200910] linearizableReadLoop","detail":"{readStateIndex:25583; appliedIndex:25576; }","duration":"351.989925ms","start":"2026-04-08T06:35:01.733161Z","end":"2026-04-08T06:35:02.085151Z","steps":["trace[1757200910] 'read index received'  (duration: 349.907764ms)","trace[1757200910] 'applied index is now lower than readState.Index'  (duration: 2.080651ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:02.085284Z","caller":"traceutil/trace.go:171","msg":"trace[2075291820] transaction","detail":"{read_only:false; response_revision:24768; number_of_response:1; }","duration":"591.381345ms","start":"2026-04-08T06:35:01.493887Z","end":"2026-04-08T06:35:02.085268Z","steps":["trace[2075291820] 'process raft request'  (duration: 590.189611ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:02.08539Z","caller":"traceutil/trace.go:171","msg":"trace[1652278150] transaction","detail":"{read_only:false; response_revision:24769; number_of_response:1; }","duration":"463.304398ms","start":"2026-04-08T06:35:01.622018Z","end":"2026-04-08T06:35:02.085323Z","steps":["trace[1652278150] 'process raft request'  (duration: 462.898189ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.085506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.49388Z","time spent":"591.530578ms","remote":"127.0.0.1:37658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5524,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/heat-engine-cleaner-29593835\" mod_revision:24753 > success:<request_put:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29593835\" value_size:5463 >> failure:<request_range:<key:\"/registry/jobs/openstack/heat-engine-cleaner-29593835\" > >"}
{"level":"warn","ts":"2026-04-08T06:35:02.085568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.62197Z","time spent":"463.478542ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24749 > 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":"info","ts":"2026-04-08T06:35:02.085619Z","caller":"traceutil/trace.go:171","msg":"trace[152022013] transaction","detail":"{read_only:false; response_revision:24771; number_of_response:1; }","duration":"459.38365ms","start":"2026-04-08T06:35:01.6262Z","end":"2026-04-08T06:35:02.085584Z","steps":["trace[152022013] 'process raft request'  (duration: 458.88875ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.085806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.626182Z","time spent":"459.529703ms","remote":"127.0.0.1:37686","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:24751 > 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-04-08T06:35:02.086022Z","caller":"traceutil/trace.go:171","msg":"trace[1866559668] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"461.900611ms","start":"2026-04-08T06:35:01.624102Z","end":"2026-04-08T06:35:02.086003Z","steps":["trace[1866559668] 'process raft request'  (duration: 460.943871ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.086097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.624094Z","time spent":"461.964092ms","remote":"127.0.0.1:37686","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:24750 > 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-04-08T06:35:02.086241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.116328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-04-08T06:35:02.086288Z","caller":"traceutil/trace.go:171","msg":"trace[108107058] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:24771; }","duration":"594.18252ms","start":"2026-04-08T06:35:01.492093Z","end":"2026-04-08T06:35:02.086275Z","steps":["trace[108107058] 'agreement among raft nodes before linearized reading'  (duration: 593.985386ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.086336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.492082Z","time spent":"594.246401ms","remote":"127.0.0.1:37454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"warn","ts":"2026-04-08T06:35:02.086342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.164105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-04-08T06:35:02.086392Z","caller":"traceutil/trace.go:171","msg":"trace[1796144648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24771; }","duration":"553.258127ms","start":"2026-04-08T06:35:01.533121Z","end":"2026-04-08T06:35:02.086379Z","steps":["trace[1796144648] 'agreement among raft nodes before linearized reading'  (duration: 553.059893ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.086427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.533099Z","time spent":"553.320778ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-08T06:35:02.263841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.904745ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975120949 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24747 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-08T06:35:02.264119Z","caller":"traceutil/trace.go:171","msg":"trace[1024316107] transaction","detail":"{read_only:false; response_revision:24772; number_of_response:1; }","duration":"525.879971ms","start":"2026-04-08T06:35:01.738198Z","end":"2026-04-08T06:35:02.264078Z","steps":["trace[1024316107] 'process raft request'  (duration: 423.63561ms)","trace[1024316107] 'compare'  (duration: 101.469336ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:02.264227Z","caller":"traceutil/trace.go:171","msg":"trace[851309957] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"173.13213ms","start":"2026-04-08T06:35:02.091073Z","end":"2026-04-08T06:35:02.264205Z","steps":["trace[851309957] 'process raft request'  (duration: 173.061468ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.264318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.738185Z","time spent":"526.027294ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24747 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-08T06:35:02.264307Z","caller":"traceutil/trace.go:171","msg":"trace[165718276] linearizableReadLoop","detail":"{readStateIndex:25585; appliedIndex:25583; }","duration":"178.991897ms","start":"2026-04-08T06:35:02.085277Z","end":"2026-04-08T06:35:02.264269Z","steps":["trace[165718276] 'read index received'  (duration: 76.48582ms)","trace[165718276] 'applied index is now lower than readState.Index'  (duration: 102.497337ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:02.264399Z","caller":"traceutil/trace.go:171","msg":"trace[251469547] transaction","detail":"{read_only:false; response_revision:24773; number_of_response:1; }","duration":"411.058409ms","start":"2026-04-08T06:35:01.853288Z","end":"2026-04-08T06:35:02.264347Z","steps":["trace[251469547] 'process raft request'  (duration: 410.666281ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:02.264565Z","caller":"traceutil/trace.go:171","msg":"trace[1669950051] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"175.618781ms","start":"2026-04-08T06:35:02.088891Z","end":"2026-04-08T06:35:02.26451Z","steps":["trace[1669950051] 'process raft request'  (duration: 175.157011ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.264645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.216363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-08T06:35:02.264652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.853264Z","time spent":"411.232973ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24752 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-08T06:35:02.264681Z","caller":"traceutil/trace.go:171","msg":"trace[533241596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24775; }","duration":"340.328775ms","start":"2026-04-08T06:35:01.924344Z","end":"2026-04-08T06:35:02.264672Z","steps":["trace[533241596] 'agreement among raft nodes before linearized reading'  (duration: 340.134471ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.264713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.924313Z","time spent":"340.393636ms","remote":"127.0.0.1:37366","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-04-08T06:35:02.264674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.890218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm\" ","response":"range_response_count:1 size:5603"}
{"level":"info","ts":"2026-04-08T06:35:02.264786Z","caller":"traceutil/trace.go:171","msg":"trace[77256563] range","detail":"{range_begin:/registry/pods/openstack/heat-engine-cleaner-29593835-w4gtm; range_end:; response_count:1; response_revision:24775; }","duration":"160.023591ms","start":"2026-04-08T06:35:02.104727Z","end":"2026-04-08T06:35:02.26475Z","steps":["trace[77256563] 'agreement among raft nodes before linearized reading'  (duration: 159.766356ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.265021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.624596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:131027"}
{"level":"info","ts":"2026-04-08T06:35:02.265082Z","caller":"traceutil/trace.go:171","msg":"trace[67628484] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:24775; }","duration":"526.690088ms","start":"2026-04-08T06:35:01.738378Z","end":"2026-04-08T06:35:02.265068Z","steps":["trace[67628484] 'agreement among raft nodes before linearized reading'  (duration: 526.425132ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:02.265121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:01.738354Z","time spent":"526.754989ms","remote":"127.0.0.1:37440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":131050,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"info","ts":"2026-04-08T06:35:02.406975Z","caller":"traceutil/trace.go:171","msg":"trace[956806711] linearizableReadLoop","detail":"{readStateIndex:25588; appliedIndex:25587; }","duration":"109.861673ms","start":"2026-04-08T06:35:02.297082Z","end":"2026-04-08T06:35:02.406944Z","steps":["trace[956806711] 'read index received'  (duration: 94.321855ms)","trace[956806711] 'applied index is now lower than readState.Index'  (duration: 15.538648ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:02.40711Z","caller":"traceutil/trace.go:171","msg":"trace[511181336] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"132.130046ms","start":"2026-04-08T06:35:02.274925Z","end":"2026-04-08T06:35:02.407055Z","steps":["trace[511181336] 'process raft request'  (duration: 116.631229ms)","trace[511181336] 'compare'  (duration: 15.202131ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:02.407348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.231201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-08T06:35:02.407515Z","caller":"traceutil/trace.go:171","msg":"trace[449576053] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24776; }","duration":"110.448706ms","start":"2026-04-08T06:35:02.297032Z","end":"2026-04-08T06:35:02.407481Z","steps":["trace[449576053] 'agreement among raft nodes before linearized reading'  (duration: 110.039007ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.130369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.36141ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975120964 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:2f679d6ba12f9043>","response":"size:41"}
{"level":"warn","ts":"2026-04-08T06:35:03.130597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:02.426424Z","time spent":"704.165996ms","remote":"127.0.0.1:37416","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-04-08T06:35:03.13066Z","caller":"traceutil/trace.go:171","msg":"trace[648499487] linearizableReadLoop","detail":"{readStateIndex:25589; appliedIndex:25588; }","duration":"681.100287ms","start":"2026-04-08T06:35:02.449522Z","end":"2026-04-08T06:35:03.130622Z","steps":["trace[648499487] 'read index received'  (duration: 230.97882ms)","trace[648499487] 'applied index is now lower than readState.Index'  (duration: 450.117257ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:03.130705Z","caller":"traceutil/trace.go:171","msg":"trace[1327470491] transaction","detail":"{read_only:false; response_revision:24777; number_of_response:1; }","duration":"349.496016ms","start":"2026-04-08T06:35:02.781185Z","end":"2026-04-08T06:35:03.130681Z","steps":["trace[1327470491] 'process raft request'  (duration: 349.333433ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.130878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:02.781152Z","time spent":"349.64932ms","remote":"127.0.0.1:37686","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:24754 > 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":"warn","ts":"2026-04-08T06:35:03.130934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.392673ms","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:6"}
{"level":"info","ts":"2026-04-08T06:35:03.130983Z","caller":"traceutil/trace.go:171","msg":"trace[516346370] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:24777; }","duration":"681.541176ms","start":"2026-04-08T06:35:02.449428Z","end":"2026-04-08T06:35:03.130969Z","steps":["trace[516346370] 'agreement among raft nodes before linearized reading'  (duration: 681.350772ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.131034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:02.449397Z","time spent":"681.624557ms","remote":"127.0.0.1:37238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "}
{"level":"info","ts":"2026-04-08T06:35:03.150099Z","caller":"traceutil/trace.go:171","msg":"trace[1221177091] transaction","detail":"{read_only:false; response_revision:24779; number_of_response:1; }","duration":"102.386585ms","start":"2026-04-08T06:35:03.047639Z","end":"2026-04-08T06:35:03.150026Z","steps":["trace[1221177091] 'process raft request'  (duration: 102.15168ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.150144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.784954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:03.15022Z","caller":"traceutil/trace.go:171","msg":"trace[473895751] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24780; }","duration":"667.928056ms","start":"2026-04-08T06:35:02.482273Z","end":"2026-04-08T06:35:03.150201Z","steps":["trace[473895751] 'agreement among raft nodes before linearized reading'  (duration: 667.690622ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.15026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:02.48225Z","time spent":"667.999487ms","remote":"127.0.0.1:37850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-04-08T06:35:03.150395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.248667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:03.15053Z","caller":"traceutil/trace.go:171","msg":"trace[338120466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24780; }","duration":"221.632004ms","start":"2026-04-08T06:35:02.928882Z","end":"2026-04-08T06:35:03.150514Z","steps":["trace[338120466] 'agreement among raft nodes before linearized reading'  (duration: 221.134845ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.150551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.403527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-08T06:35:03.150582Z","caller":"traceutil/trace.go:171","msg":"trace[446821582] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:24780; }","duration":"502.514849ms","start":"2026-04-08T06:35:02.648055Z","end":"2026-04-08T06:35:03.15057Z","steps":["trace[446821582] 'agreement among raft nodes before linearized reading'  (duration: 502.413177ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:03.150613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:02.648025Z","time spent":"502.576119ms","remote":"127.0.0.1:37886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":38,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"info","ts":"2026-04-08T06:35:05.91707Z","caller":"traceutil/trace.go:171","msg":"trace[1158926782] transaction","detail":"{read_only:false; response_revision:24807; number_of_response:1; }","duration":"163.239304ms","start":"2026-04-08T06:35:05.753804Z","end":"2026-04-08T06:35:05.917043Z","steps":["trace[1158926782] 'process raft request'  (duration: 163.03734ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:06.201581Z","caller":"traceutil/trace.go:171","msg":"trace[1157531882] linearizableReadLoop","detail":"{readStateIndex:25621; appliedIndex:25619; }","duration":"445.319821ms","start":"2026-04-08T06:35:05.756237Z","end":"2026-04-08T06:35:06.201557Z","steps":["trace[1157531882] 'read index received'  (duration: 160.614842ms)","trace[1157531882] 'applied index is now lower than readState.Index'  (duration: 284.703839ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:06.201908Z","caller":"traceutil/trace.go:171","msg":"trace[1291987918] transaction","detail":"{read_only:false; response_revision:24808; number_of_response:1; }","duration":"446.590916ms","start":"2026-04-08T06:35:05.755308Z","end":"2026-04-08T06:35:06.201899Z","steps":["trace[1291987918] 'process raft request'  (duration: 446.108027ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.20204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:05.755279Z","time spent":"446.654048ms","remote":"127.0.0.1:37686","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:24790 > 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":"warn","ts":"2026-04-08T06:35:06.202234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.996024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:06.202264Z","caller":"traceutil/trace.go:171","msg":"trace[1517739794] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24808; }","duration":"446.053466ms","start":"2026-04-08T06:35:05.756201Z","end":"2026-04-08T06:35:06.202255Z","steps":["trace[1517739794] 'agreement among raft nodes before linearized reading'  (duration: 446.002865ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.202301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:05.756193Z","time spent":"446.102067ms","remote":"127.0.0.1:37688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "}
{"level":"info","ts":"2026-04-08T06:35:06.365486Z","caller":"traceutil/trace.go:171","msg":"trace[1208682651] transaction","detail":"{read_only:false; response_revision:24809; number_of_response:1; }","duration":"268.22559ms","start":"2026-04-08T06:35:06.097226Z","end":"2026-04-08T06:35:06.365452Z","steps":["trace[1208682651] 'process raft request'  (duration: 267.792602ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:06.365785Z","caller":"traceutil/trace.go:171","msg":"trace[1413239661] transaction","detail":"{read_only:false; response_revision:24810; number_of_response:1; }","duration":"263.767433ms","start":"2026-04-08T06:35:06.101985Z","end":"2026-04-08T06:35:06.365753Z","steps":["trace[1413239661] 'process raft request'  (duration: 263.405465ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:06.366259Z","caller":"traceutil/trace.go:171","msg":"trace[1653548239] transaction","detail":"{read_only:false; response_revision:24811; number_of_response:1; }","duration":"264.020419ms","start":"2026-04-08T06:35:06.102223Z","end":"2026-04-08T06:35:06.366243Z","steps":["trace[1653548239] 'process raft request'  (duration: 263.492658ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.366333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.093393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:06.366406Z","caller":"traceutil/trace.go:171","msg":"trace[868695020] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24811; }","duration":"323.229066ms","start":"2026-04-08T06:35:06.043161Z","end":"2026-04-08T06:35:06.36639Z","steps":["trace[868695020] 'agreement among raft nodes before linearized reading'  (duration: 323.095053ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.366437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:06.043141Z","time spent":"323.289726ms","remote":"127.0.0.1:50680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T06:35:06.366361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.943762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:06.366222Z","caller":"traceutil/trace.go:171","msg":"trace[1147413418] linearizableReadLoop","detail":"{readStateIndex:25624; appliedIndex:25621; }","duration":"164.561351ms","start":"2026-04-08T06:35:06.20165Z","end":"2026-04-08T06:35:06.366212Z","steps":["trace[1147413418] 'read index received'  (duration: 163.369247ms)","trace[1147413418] 'applied index is now lower than readState.Index'  (duration: 1.191284ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:06.366526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.823873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:06.366577Z","caller":"traceutil/trace.go:171","msg":"trace[1328195379] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24811; }","duration":"216.185447ms","start":"2026-04-08T06:35:06.150342Z","end":"2026-04-08T06:35:06.366528Z","steps":["trace[1328195379] 'agreement among raft nodes before linearized reading'  (duration: 215.900482ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:06.366626Z","caller":"traceutil/trace.go:171","msg":"trace[2099173726] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24811; }","duration":"429.005617ms","start":"2026-04-08T06:35:05.937598Z","end":"2026-04-08T06:35:06.366604Z","steps":["trace[2099173726] 'agreement among raft nodes before linearized reading'  (duration: 428.816773ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.366684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:05.937568Z","time spent":"429.104319ms","remote":"127.0.0.1:50800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "}
{"level":"info","ts":"2026-04-08T06:35:06.379749Z","caller":"traceutil/trace.go:171","msg":"trace[495407923] transaction","detail":"{read_only:false; response_revision:24812; number_of_response:1; }","duration":"101.311074ms","start":"2026-04-08T06:35:06.278419Z","end":"2026-04-08T06:35:06.37973Z","steps":["trace[495407923] 'process raft request'  (duration: 101.108649ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.37977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.01659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:06.37983Z","caller":"traceutil/trace.go:171","msg":"trace[1350814855] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24812; }","duration":"172.098101ms","start":"2026-04-08T06:35:06.207715Z","end":"2026-04-08T06:35:06.379813Z","steps":["trace[1350814855] 'agreement among raft nodes before linearized reading'  (duration: 171.949919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:06.677589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.574703ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975121038 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24798 > 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-04-08T06:35:06.677696Z","caller":"traceutil/trace.go:171","msg":"trace[1637377658] linearizableReadLoop","detail":"{readStateIndex:25627; appliedIndex:25626; }","duration":"226.607804ms","start":"2026-04-08T06:35:06.451075Z","end":"2026-04-08T06:35:06.677683Z","steps":["trace[1637377658] 'read index received'  (duration: 75.781996ms)","trace[1637377658] 'applied index is now lower than readState.Index'  (duration: 150.824628ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:06.677785Z","caller":"traceutil/trace.go:171","msg":"trace[156765298] transaction","detail":"{read_only:false; response_revision:24814; number_of_response:1; }","duration":"291.366501ms","start":"2026-04-08T06:35:06.386411Z","end":"2026-04-08T06:35:06.677778Z","steps":["trace[156765298] 'process raft request'  (duration: 140.525313ms)","trace[156765298] 'compare'  (duration: 150.456711ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:06.677956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.940983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-08T06:35:06.678054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.996971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:06.678075Z","caller":"traceutil/trace.go:171","msg":"trace[1334550809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24814; }","duration":"227.077713ms","start":"2026-04-08T06:35:06.450989Z","end":"2026-04-08T06:35:06.678067Z","steps":["trace[1334550809] 'agreement among raft nodes before linearized reading'  (duration: 227.036952ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:06.678066Z","caller":"traceutil/trace.go:171","msg":"trace[624269173] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24814; }","duration":"131.121786ms","start":"2026-04-08T06:35:06.546919Z","end":"2026-04-08T06:35:06.67804Z","steps":["trace[624269173] 'agreement among raft nodes before linearized reading'  (duration: 130.942323ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:07.265812Z","caller":"traceutil/trace.go:171","msg":"trace[1925529307] transaction","detail":"{read_only:false; response_revision:24815; number_of_response:1; }","duration":"118.938174ms","start":"2026-04-08T06:35:07.146839Z","end":"2026-04-08T06:35:07.265778Z","steps":["trace[1925529307] 'process raft request'  (duration: 118.758961ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:07.311848Z","caller":"traceutil/trace.go:171","msg":"trace[551620489] transaction","detail":"{read_only:false; response_revision:24816; number_of_response:1; }","duration":"153.141343ms","start":"2026-04-08T06:35:07.158683Z","end":"2026-04-08T06:35:07.311824Z","steps":["trace[551620489] 'process raft request'  (duration: 152.677094ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:07.312171Z","caller":"traceutil/trace.go:171","msg":"trace[839697248] transaction","detail":"{read_only:false; response_revision:24817; number_of_response:1; }","duration":"144.852678ms","start":"2026-04-08T06:35:07.16731Z","end":"2026-04-08T06:35:07.312163Z","steps":["trace[839697248] 'process raft request'  (duration: 144.205916ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:12.279229Z","caller":"traceutil/trace.go:171","msg":"trace[855275467] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"242.279214ms","start":"2026-04-08T06:35:12.03691Z","end":"2026-04-08T06:35:12.279189Z","steps":["trace[855275467] 'process raft request'  (duration: 151.060642ms)","trace[855275467] 'compare'  (duration: 90.885286ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:12.279386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.252137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:12.279222Z","caller":"traceutil/trace.go:171","msg":"trace[1692583068] linearizableReadLoop","detail":"{readStateIndex:25670; appliedIndex:25669; }","duration":"142.083933ms","start":"2026-04-08T06:35:12.137101Z","end":"2026-04-08T06:35:12.279185Z","steps":["trace[1692583068] 'read index received'  (duration: 50.919212ms)","trace[1692583068] 'applied index is now lower than readState.Index'  (duration: 91.162771ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:12.279436Z","caller":"traceutil/trace.go:171","msg":"trace[154108676] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:24856; }","duration":"142.37416ms","start":"2026-04-08T06:35:12.137049Z","end":"2026-04-08T06:35:12.279423Z","steps":["trace[154108676] 'agreement among raft nodes before linearized reading'  (duration: 142.255297ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:12.354677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.3012ms","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-04-08T06:35:12.354793Z","caller":"traceutil/trace.go:171","msg":"trace[1862721153] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24857; }","duration":"129.486274ms","start":"2026-04-08T06:35:12.225278Z","end":"2026-04-08T06:35:12.354764Z","steps":["trace[1862721153] 'agreement among raft nodes before linearized reading'  (duration: 129.227418ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:12.516408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.658629ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975121144 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24842 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-08T06:35:12.516582Z","caller":"traceutil/trace.go:171","msg":"trace[1992854136] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"157.115743ms","start":"2026-04-08T06:35:12.359409Z","end":"2026-04-08T06:35:12.516525Z","steps":["trace[1992854136] 'process raft request'  (duration: 42.215789ms)","trace[1992854136] 'compare'  (duration: 114.505826ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:12.517371Z","caller":"traceutil/trace.go:171","msg":"trace[1704309504] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"119.847972ms","start":"2026-04-08T06:35:12.397491Z","end":"2026-04-08T06:35:12.517339Z","steps":["trace[1704309504] 'process raft request'  (duration: 119.617267ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:12.517597Z","caller":"traceutil/trace.go:171","msg":"trace[1444390543] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"117.924164ms","start":"2026-04-08T06:35:12.399655Z","end":"2026-04-08T06:35:12.517579Z","steps":["trace[1444390543] 'process raft request'  (duration: 117.792212ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:12.517753Z","caller":"traceutil/trace.go:171","msg":"trace[1085792029] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"118.433125ms","start":"2026-04-08T06:35:12.399309Z","end":"2026-04-08T06:35:12.517742Z","steps":["trace[1085792029] 'process raft request'  (duration: 117.979505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:12.517822Z","caller":"traceutil/trace.go:171","msg":"trace[98295251] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"117.944274ms","start":"2026-04-08T06:35:12.399852Z","end":"2026-04-08T06:35:12.517796Z","steps":["trace[98295251] 'process raft request'  (duration: 117.687349ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:13.039634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.224891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:13.039729Z","caller":"traceutil/trace.go:171","msg":"trace[777047441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24865; }","duration":"116.333463ms","start":"2026-04-08T06:35:12.923376Z","end":"2026-04-08T06:35:13.03971Z","steps":["trace[777047441] 'range keys from in-memory index tree'  (duration: 116.115178ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:13.446056Z","caller":"traceutil/trace.go:171","msg":"trace[1568310432] transaction","detail":"{read_only:false; response_revision:24866; number_of_response:1; }","duration":"151.493281ms","start":"2026-04-08T06:35:13.294536Z","end":"2026-04-08T06:35:13.446029Z","steps":["trace[1568310432] 'process raft request'  (duration: 151.325668ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:13.446162Z","caller":"traceutil/trace.go:171","msg":"trace[457385944] linearizableReadLoop","detail":"{readStateIndex:25681; appliedIndex:25681; }","duration":"121.518485ms","start":"2026-04-08T06:35:13.324604Z","end":"2026-04-08T06:35:13.446122Z","steps":["trace[457385944] 'read index received'  (duration: 121.497575ms)","trace[457385944] 'applied index is now lower than readState.Index'  (duration: 18.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:13.446358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.723719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:13.446422Z","caller":"traceutil/trace.go:171","msg":"trace[692798402] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24866; }","duration":"121.884262ms","start":"2026-04-08T06:35:13.32452Z","end":"2026-04-08T06:35:13.446405Z","steps":["trace[692798402] 'agreement among raft nodes before linearized reading'  (duration: 121.745929ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:13.56034Z","caller":"traceutil/trace.go:171","msg":"trace[1586256571] transaction","detail":"{read_only:false; response_revision:24867; number_of_response:1; }","duration":"221.543603ms","start":"2026-04-08T06:35:13.338766Z","end":"2026-04-08T06:35:13.56031Z","steps":["trace[1586256571] 'process raft request'  (duration: 221.316228ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:13.560637Z","caller":"traceutil/trace.go:171","msg":"trace[642442978] transaction","detail":"{read_only:false; response_revision:24868; number_of_response:1; }","duration":"219.795669ms","start":"2026-04-08T06:35:13.340831Z","end":"2026-04-08T06:35:13.560627Z","steps":["trace[642442978] 'process raft request'  (duration: 219.431092ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:13.560815Z","caller":"traceutil/trace.go:171","msg":"trace[1193367193] linearizableReadLoop","detail":"{readStateIndex:25684; appliedIndex:25681; }","duration":"114.556806ms","start":"2026-04-08T06:35:13.446248Z","end":"2026-04-08T06:35:13.560805Z","steps":["trace[1193367193] 'read index received'  (duration: 113.819032ms)","trace[1193367193] 'applied index is now lower than readState.Index'  (duration: 736.454µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:13.560926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.972884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:13.560955Z","caller":"traceutil/trace.go:171","msg":"trace[751618603] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24869; }","duration":"202.053785ms","start":"2026-04-08T06:35:13.358895Z","end":"2026-04-08T06:35:13.560949Z","steps":["trace[751618603] 'agreement among raft nodes before linearized reading'  (duration: 201.952833ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:13.561053Z","caller":"traceutil/trace.go:171","msg":"trace[1822041991] transaction","detail":"{read_only:false; response_revision:24869; number_of_response:1; }","duration":"219.497622ms","start":"2026-04-08T06:35:13.34152Z","end":"2026-04-08T06:35:13.561017Z","steps":["trace[1822041991] 'process raft request'  (duration: 219.076683ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:13.561175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.927462ms","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-04-08T06:35:13.561205Z","caller":"traceutil/trace.go:171","msg":"trace[1495141062] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24869; }","duration":"135.998592ms","start":"2026-04-08T06:35:13.425197Z","end":"2026-04-08T06:35:13.561196Z","steps":["trace[1495141062] 'agreement among raft nodes before linearized reading'  (duration: 135.89412ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:15.824028Z","caller":"traceutil/trace.go:171","msg":"trace[508299300] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"257.301134ms","start":"2026-04-08T06:35:15.566691Z","end":"2026-04-08T06:35:15.823993Z","steps":["trace[508299300] 'process raft request'  (duration: 257.073689ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:15.829225Z","caller":"traceutil/trace.go:171","msg":"trace[1235500943] transaction","detail":"{read_only:false; response_revision:24885; number_of_response:1; }","duration":"262.046819ms","start":"2026-04-08T06:35:15.567164Z","end":"2026-04-08T06:35:15.829211Z","steps":["trace[1235500943] 'process raft request'  (duration: 261.916496ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:15.829419Z","caller":"traceutil/trace.go:171","msg":"trace[1230363219] linearizableReadLoop","detail":"{readStateIndex:25701; appliedIndex:25698; }","duration":"256.999728ms","start":"2026-04-08T06:35:15.572379Z","end":"2026-04-08T06:35:15.829379Z","steps":["trace[1230363219] 'read index received'  (duration: 251.398466ms)","trace[1230363219] 'applied index is now lower than readState.Index'  (duration: 5.598382ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:15.829469Z","caller":"traceutil/trace.go:171","msg":"trace[1384301360] transaction","detail":"{read_only:false; response_revision:24886; number_of_response:1; }","duration":"262.11584ms","start":"2026-04-08T06:35:15.567321Z","end":"2026-04-08T06:35:15.829437Z","steps":["trace[1384301360] 'process raft request'  (duration: 261.849985ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:15.829672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.282314ms","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-04-08T06:35:15.82972Z","caller":"traceutil/trace.go:171","msg":"trace[99964351] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24886; }","duration":"257.400466ms","start":"2026-04-08T06:35:15.572306Z","end":"2026-04-08T06:35:15.829707Z","steps":["trace[99964351] 'agreement among raft nodes before linearized reading'  (duration: 257.230293ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:16.113866Z","caller":"traceutil/trace.go:171","msg":"trace[726857882] transaction","detail":"{read_only:false; response_revision:24888; number_of_response:1; }","duration":"143.506312ms","start":"2026-04-08T06:35:15.970328Z","end":"2026-04-08T06:35:16.113835Z","steps":["trace[726857882] 'process raft request'  (duration: 143.327218ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:16.127634Z","caller":"traceutil/trace.go:171","msg":"trace[1532659865] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"152.662294ms","start":"2026-04-08T06:35:15.97494Z","end":"2026-04-08T06:35:16.127602Z","steps":["trace[1532659865] 'process raft request'  (duration: 152.412109ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:18.053778Z","caller":"traceutil/trace.go:171","msg":"trace[1038005257] transaction","detail":"{read_only:false; response_revision:24904; number_of_response:1; }","duration":"223.756257ms","start":"2026-04-08T06:35:17.829999Z","end":"2026-04-08T06:35:18.053755Z","steps":["trace[1038005257] 'process raft request'  (duration: 223.602594ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:18.240821Z","caller":"traceutil/trace.go:171","msg":"trace[1573355970] transaction","detail":"{read_only:false; response_revision:24905; number_of_response:1; }","duration":"405.592942ms","start":"2026-04-08T06:35:17.835202Z","end":"2026-04-08T06:35:18.240795Z","steps":["trace[1573355970] 'process raft request'  (duration: 404.721084ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:18.240981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:17.835191Z","time spent":"405.702644ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"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:24885 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-08T06:35:18.240998Z","caller":"traceutil/trace.go:171","msg":"trace[520816602] linearizableReadLoop","detail":"{readStateIndex:25721; appliedIndex:25718; }","duration":"387.519923ms","start":"2026-04-08T06:35:17.853453Z","end":"2026-04-08T06:35:18.240973Z","steps":["trace[520816602] 'read index received'  (duration: 200.168229ms)","trace[520816602] 'applied index is now lower than readState.Index'  (duration: 187.350914ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:18.241097Z","caller":"traceutil/trace.go:171","msg":"trace[1213647865] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"405.094022ms","start":"2026-04-08T06:35:17.835996Z","end":"2026-04-08T06:35:18.24109Z","steps":["trace[1213647865] 'process raft request'  (duration: 404.744745ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:18.24119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:17.835986Z","time spent":"405.131423ms","remote":"127.0.0.1:37686","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:24886 > 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":"warn","ts":"2026-04-08T06:35:18.241512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.029183ms","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-04-08T06:35:18.241937Z","caller":"traceutil/trace.go:171","msg":"trace[1946431685] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24906; }","duration":"388.490322ms","start":"2026-04-08T06:35:17.853419Z","end":"2026-04-08T06:35:18.241909Z","steps":["trace[1946431685] 'agreement among raft nodes before linearized reading'  (duration: 387.88871ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:18.242041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:17.853407Z","time spent":"388.617234ms","remote":"127.0.0.1:37686","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":"warn","ts":"2026-04-08T06:35:18.244171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.879968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:18.244271Z","caller":"traceutil/trace.go:171","msg":"trace[1361855690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24906; }","duration":"319.002491ms","start":"2026-04-08T06:35:17.925254Z","end":"2026-04-08T06:35:18.244257Z","steps":["trace[1361855690] 'agreement among raft nodes before linearized reading'  (duration: 318.873158ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:18.244337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:17.925244Z","time spent":"319.081742ms","remote":"127.0.0.1:37366","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-04-08T06:35:18.244413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.278777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:18.244467Z","caller":"traceutil/trace.go:171","msg":"trace[1170245121] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24906; }","duration":"227.354258ms","start":"2026-04-08T06:35:18.017097Z","end":"2026-04-08T06:35:18.244451Z","steps":["trace[1170245121] 'agreement among raft nodes before linearized reading'  (duration: 227.279287ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:18.244752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.565326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-04-08T06:35:18.244849Z","caller":"traceutil/trace.go:171","msg":"trace[224437162] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:24906; }","duration":"283.679508ms","start":"2026-04-08T06:35:17.961155Z","end":"2026-04-08T06:35:18.244834Z","steps":["trace[224437162] 'agreement among raft nodes before linearized reading'  (duration: 283.506784ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:18.244325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.15317ms","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-04-08T06:35:18.244942Z","caller":"traceutil/trace.go:171","msg":"trace[784455124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24906; }","duration":"104.814813ms","start":"2026-04-08T06:35:18.140121Z","end":"2026-04-08T06:35:18.244935Z","steps":["trace[784455124] 'agreement among raft nodes before linearized reading'  (duration: 104.076368ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:21.699346Z","caller":"traceutil/trace.go:171","msg":"trace[1651468879] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"171.494659ms","start":"2026-04-08T06:35:21.527828Z","end":"2026-04-08T06:35:21.699323Z","steps":["trace[1651468879] 'process raft request'  (duration: 171.326375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:27.43201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.972586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:27.432118Z","caller":"traceutil/trace.go:171","msg":"trace[271784873] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:25045; }","duration":"197.14156ms","start":"2026-04-08T06:35:27.234953Z","end":"2026-04-08T06:35:27.432094Z","steps":["trace[271784873] 'count revisions from in-memory index tree'  (duration: 196.845543ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:27.432236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.941612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:27.43232Z","caller":"traceutil/trace.go:171","msg":"trace[412879955] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:25045; }","duration":"149.100575ms","start":"2026-04-08T06:35:27.283202Z","end":"2026-04-08T06:35:27.432302Z","steps":["trace[412879955] 'count revisions from in-memory index tree'  (duration: 148.765138ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:27.432875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.991131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-04-08T06:35:27.432954Z","caller":"traceutil/trace.go:171","msg":"trace[764046221] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25045; }","duration":"149.107994ms","start":"2026-04-08T06:35:27.28383Z","end":"2026-04-08T06:35:27.432938Z","steps":["trace[764046221] 'range keys from in-memory index tree'  (duration: 148.831478ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:27.544658Z","caller":"traceutil/trace.go:171","msg":"trace[197948756] transaction","detail":"{read_only:false; response_revision:25046; number_of_response:1; }","duration":"176.283874ms","start":"2026-04-08T06:35:27.368347Z","end":"2026-04-08T06:35:27.544631Z","steps":["trace[197948756] 'process raft request'  (duration: 176.06537ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:27.626836Z","caller":"traceutil/trace.go:171","msg":"trace[325707604] linearizableReadLoop","detail":"{readStateIndex:25865; appliedIndex:25863; }","duration":"123.111997ms","start":"2026-04-08T06:35:27.503707Z","end":"2026-04-08T06:35:27.626819Z","steps":["trace[325707604] 'read index received'  (duration: 40.188819ms)","trace[325707604] 'applied index is now lower than readState.Index'  (duration: 82.922158ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:27.626908Z","caller":"traceutil/trace.go:171","msg":"trace[592360721] transaction","detail":"{read_only:false; response_revision:25047; number_of_response:1; }","duration":"188.073288ms","start":"2026-04-08T06:35:27.438811Z","end":"2026-04-08T06:35:27.626884Z","steps":["trace[592360721] 'process raft request'  (duration: 187.926485ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:27.627146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.403873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5b59a14d-f880-48e7-b767-9c8fe6f3cc69\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-04-08T06:35:27.627253Z","caller":"traceutil/trace.go:171","msg":"trace[1256903892] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5b59a14d-f880-48e7-b767-9c8fe6f3cc69; range_end:; response_count:1; response_revision:25047; }","duration":"123.566836ms","start":"2026-04-08T06:35:27.503662Z","end":"2026-04-08T06:35:27.627229Z","steps":["trace[1256903892] 'agreement among raft nodes before linearized reading'  (duration: 123.22054ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:27.752972Z","caller":"traceutil/trace.go:171","msg":"trace[297277500] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"119.039836ms","start":"2026-04-08T06:35:27.633892Z","end":"2026-04-08T06:35:27.752932Z","steps":["trace[297277500] 'process raft request'  (duration: 118.808691ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:28.106977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.277438ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975121634 > lease_revoke:<id:2f679d6ba12f90ff>","response":"size:29"}
{"level":"info","ts":"2026-04-08T06:35:28.107374Z","caller":"traceutil/trace.go:171","msg":"trace[2030190594] linearizableReadLoop","detail":"{readStateIndex:25868; appliedIndex:25866; }","duration":"383.135455ms","start":"2026-04-08T06:35:27.724216Z","end":"2026-04-08T06:35:28.107351Z","steps":["trace[2030190594] 'read index received'  (duration: 29.436435ms)","trace[2030190594] 'applied index is now lower than readState.Index'  (duration: 353.69766ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:28.107502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.271318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:28.107535Z","caller":"traceutil/trace.go:171","msg":"trace[55783296] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:25049; }","duration":"383.3615ms","start":"2026-04-08T06:35:27.724161Z","end":"2026-04-08T06:35:28.107522Z","steps":["trace[55783296] 'agreement among raft nodes before linearized reading'  (duration: 383.262018ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:28.107582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:27.724143Z","time spent":"383.425121ms","remote":"127.0.0.1:37282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "}
{"level":"info","ts":"2026-04-08T06:35:28.107689Z","caller":"traceutil/trace.go:171","msg":"trace[1141417435] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"387.255527ms","start":"2026-04-08T06:35:27.720391Z","end":"2026-04-08T06:35:28.107646Z","steps":["trace[1141417435] 'process raft request'  (duration: 386.708067ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:28.107889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:27.720372Z","time spent":"387.409851ms","remote":"127.0.0.1:37686","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:24971 > 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-04-08T06:35:34.798096Z","caller":"traceutil/trace.go:171","msg":"trace[1340296621] linearizableReadLoop","detail":"{readStateIndex:25942; appliedIndex:25940; }","duration":"346.487876ms","start":"2026-04-08T06:35:34.451578Z","end":"2026-04-08T06:35:34.798066Z","steps":["trace[1340296621] 'read index received'  (duration: 9.417767ms)","trace[1340296621] 'applied index is now lower than readState.Index'  (duration: 337.068499ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:34.798208Z","caller":"traceutil/trace.go:171","msg":"trace[2112057294] transaction","detail":"{read_only:false; response_revision:25121; number_of_response:1; }","duration":"398.962729ms","start":"2026-04-08T06:35:34.399203Z","end":"2026-04-08T06:35:34.798165Z","steps":["trace[2112057294] 'process raft request'  (duration: 398.679094ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.798381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.762833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-08T06:35:34.798441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.399173Z","time spent":"399.148613ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"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:25094 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-08T06:35:34.798483Z","caller":"traceutil/trace.go:171","msg":"trace[1855781645] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25121; }","duration":"346.937185ms","start":"2026-04-08T06:35:34.451528Z","end":"2026-04-08T06:35:34.798465Z","steps":["trace[1855781645] 'agreement among raft nodes before linearized reading'  (duration: 346.700861ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.798536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.451505Z","time spent":"347.019947ms","remote":"127.0.0.1:50600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "}
{"level":"info","ts":"2026-04-08T06:35:34.935974Z","caller":"traceutil/trace.go:171","msg":"trace[303544051] transaction","detail":"{read_only:false; response_revision:25122; number_of_response:1; }","duration":"335.54292ms","start":"2026-04-08T06:35:34.600405Z","end":"2026-04-08T06:35:34.935948Z","steps":["trace[303544051] 'process raft request'  (duration: 331.306086ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.936116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.600381Z","time spent":"335.655821ms","remote":"127.0.0.1:37686","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:25098 > 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-04-08T06:35:34.936607Z","caller":"traceutil/trace.go:171","msg":"trace[1544065987] transaction","detail":"{read_only:false; response_revision:25123; number_of_response:1; }","duration":"334.383166ms","start":"2026-04-08T06:35:34.602183Z","end":"2026-04-08T06:35:34.936566Z","steps":["trace[1544065987] 'process raft request'  (duration: 333.721833ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:34.936709Z","caller":"traceutil/trace.go:171","msg":"trace[438362163] transaction","detail":"{read_only:false; response_revision:25124; number_of_response:1; }","duration":"334.238063ms","start":"2026-04-08T06:35:34.602458Z","end":"2026-04-08T06:35:34.936696Z","steps":["trace[438362163] 'process raft request'  (duration: 333.889567ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.936764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.602446Z","time spent":"334.292894ms","remote":"127.0.0.1:37686","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:25100 > 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-04-08T06:35:34.936788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.602147Z","time spent":"334.539489ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25099 > 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":"info","ts":"2026-04-08T06:35:34.936871Z","caller":"traceutil/trace.go:171","msg":"trace[420453824] linearizableReadLoop","detail":"{readStateIndex:25946; appliedIndex:25942; }","duration":"138.669576ms","start":"2026-04-08T06:35:34.798179Z","end":"2026-04-08T06:35:34.936848Z","steps":["trace[420453824] 'read index received'  (duration: 133.537174ms)","trace[420453824] 'applied index is now lower than readState.Index'  (duration: 5.130432ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:34.938085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.721846ms","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-04-08T06:35:34.938174Z","caller":"traceutil/trace.go:171","msg":"trace[2003049236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25125; }","duration":"226.851079ms","start":"2026-04-08T06:35:34.711287Z","end":"2026-04-08T06:35:34.938138Z","steps":["trace[2003049236] 'agreement among raft nodes before linearized reading'  (duration: 225.569274ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:34.938679Z","caller":"traceutil/trace.go:171","msg":"trace[1823474221] transaction","detail":"{read_only:false; response_revision:25125; number_of_response:1; }","duration":"327.921989ms","start":"2026-04-08T06:35:34.60898Z","end":"2026-04-08T06:35:34.936902Z","steps":["trace[1823474221] 'process raft request'  (duration: 327.685714ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.939046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.608969Z","time spent":"329.786895ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25101 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-04-08T06:35:34.939259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.856798ms","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-04-08T06:35:34.939306Z","caller":"traceutil/trace.go:171","msg":"trace[677153064] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25125; }","duration":"478.94945ms","start":"2026-04-08T06:35:34.460344Z","end":"2026-04-08T06:35:34.939293Z","steps":["trace[677153064] 'agreement among raft nodes before linearized reading'  (duration: 476.559513ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.939363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.46032Z","time spent":"479.035141ms","remote":"127.0.0.1:37686","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":"warn","ts":"2026-04-08T06:35:34.939441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.734564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-08T06:35:34.939559Z","caller":"traceutil/trace.go:171","msg":"trace[120256238] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25125; }","duration":"322.890407ms","start":"2026-04-08T06:35:34.616631Z","end":"2026-04-08T06:35:34.939521Z","steps":["trace[120256238] 'agreement among raft nodes before linearized reading'  (duration: 320.265556ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.939611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.616618Z","time spent":"322.98273ms","remote":"127.0.0.1:37686","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-04-08T06:35:34.939655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.602533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-04-08T06:35:34.939738Z","caller":"traceutil/trace.go:171","msg":"trace[1865708491] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25125; }","duration":"479.730246ms","start":"2026-04-08T06:35:34.459979Z","end":"2026-04-08T06:35:34.939709Z","steps":["trace[1865708491] 'agreement among raft nodes before linearized reading'  (duration: 477.001022ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:34.939782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:34.459964Z","time spent":"479.808937ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-08T06:35:35.23556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.609541ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975121805 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25106 > 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-04-08T06:35:35.235758Z","caller":"traceutil/trace.go:171","msg":"trace[1558109659] transaction","detail":"{read_only:false; response_revision:25126; number_of_response:1; }","duration":"292.32446ms","start":"2026-04-08T06:35:34.943402Z","end":"2026-04-08T06:35:35.235727Z","steps":["trace[1558109659] 'process raft request'  (duration: 128.393662ms)","trace[1558109659] 'compare'  (duration: 163.373837ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:35.239084Z","caller":"traceutil/trace.go:171","msg":"trace[858267024] linearizableReadLoop","detail":"{readStateIndex:25952; appliedIndex:25947; }","duration":"163.025431ms","start":"2026-04-08T06:35:35.076023Z","end":"2026-04-08T06:35:35.239048Z","steps":["trace[858267024] 'read index received'  (duration: 162.49549ms)","trace[858267024] 'applied index is now lower than readState.Index'  (duration: 528.321µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:35.239136Z","caller":"traceutil/trace.go:171","msg":"trace[1034358810] transaction","detail":"{read_only:false; response_revision:25128; number_of_response:1; }","duration":"293.35159ms","start":"2026-04-08T06:35:34.945724Z","end":"2026-04-08T06:35:35.239076Z","steps":["trace[1034358810] 'process raft request'  (duration: 293.148686ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:35.239251Z","caller":"traceutil/trace.go:171","msg":"trace[188012550] transaction","detail":"{read_only:false; response_revision:25131; number_of_response:1; }","duration":"188.008036ms","start":"2026-04-08T06:35:35.051223Z","end":"2026-04-08T06:35:35.239231Z","steps":["trace[188012550] 'process raft request'  (duration: 187.776782ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:35.239203Z","caller":"traceutil/trace.go:171","msg":"trace[1788160285] transaction","detail":"{read_only:false; response_revision:25130; number_of_response:1; }","duration":"288.77561ms","start":"2026-04-08T06:35:34.950374Z","end":"2026-04-08T06:35:35.23915Z","steps":["trace[1788160285] 'process raft request'  (duration: 288.589736ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:35.239332Z","caller":"traceutil/trace.go:171","msg":"trace[850046869] transaction","detail":"{read_only:false; response_revision:25129; number_of_response:1; }","duration":"293.434382ms","start":"2026-04-08T06:35:34.945828Z","end":"2026-04-08T06:35:35.239263Z","steps":["trace[850046869] 'process raft request'  (duration: 293.098705ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:35.239524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.46869ms","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-04-08T06:35:35.239621Z","caller":"traceutil/trace.go:171","msg":"trace[56225712] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25131; }","duration":"163.583072ms","start":"2026-04-08T06:35:35.076013Z","end":"2026-04-08T06:35:35.239596Z","steps":["trace[56225712] 'agreement among raft nodes before linearized reading'  (duration: 163.371658ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:35.239537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.382855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:35.239695Z","caller":"traceutil/trace.go:171","msg":"trace[2085721376] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:25131; }","duration":"104.60933ms","start":"2026-04-08T06:35:35.135063Z","end":"2026-04-08T06:35:35.239672Z","steps":["trace[2085721376] 'agreement among raft nodes before linearized reading'  (duration: 104.325964ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:35.239831Z","caller":"traceutil/trace.go:171","msg":"trace[1020352729] transaction","detail":"{read_only:false; response_revision:25127; number_of_response:1; }","duration":"294.153967ms","start":"2026-04-08T06:35:34.945567Z","end":"2026-04-08T06:35:35.239721Z","steps":["trace[1020352729] 'process raft request'  (duration: 293.097235ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:42.271451Z","caller":"traceutil/trace.go:171","msg":"trace[752809667] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"110.552478ms","start":"2026-04-08T06:35:42.160871Z","end":"2026-04-08T06:35:42.271423Z","steps":["trace[752809667] 'process raft request'  (duration: 110.383255ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:42.482106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.566355ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975121948 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25171 > 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-04-08T06:35:42.48225Z","caller":"traceutil/trace.go:171","msg":"trace[769796561] linearizableReadLoop","detail":"{readStateIndex:26010; appliedIndex:26008; }","duration":"291.480534ms","start":"2026-04-08T06:35:42.190749Z","end":"2026-04-08T06:35:42.48223Z","steps":["trace[769796561] 'read index received'  (duration: 80.569692ms)","trace[769796561] 'applied index is now lower than readState.Index'  (duration: 210.909142ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:42.482515Z","caller":"traceutil/trace.go:171","msg":"trace[441842952] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"316.615373ms","start":"2026-04-08T06:35:42.165851Z","end":"2026-04-08T06:35:42.482466Z","steps":["trace[441842952] 'process raft request'  (duration: 182.578889ms)","trace[441842952] 'compare'  (duration: 133.341921ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:42.482541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.749679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:42.48268Z","caller":"traceutil/trace.go:171","msg":"trace[1073536018] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:25188; }","duration":"291.954903ms","start":"2026-04-08T06:35:42.190698Z","end":"2026-04-08T06:35:42.482653Z","steps":["trace[1073536018] 'agreement among raft nodes before linearized reading'  (duration: 291.693598ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:42.482707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:42.165829Z","time spent":"316.778006ms","remote":"127.0.0.1:37686","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:25171 > 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-04-08T06:35:42.78195Z","caller":"traceutil/trace.go:171","msg":"trace[1760837376] linearizableReadLoop","detail":"{readStateIndex:26012; appliedIndex:26010; }","duration":"218.37733ms","start":"2026-04-08T06:35:42.563544Z","end":"2026-04-08T06:35:42.781921Z","steps":["trace[1760837376] 'read index received'  (duration: 216.536443ms)","trace[1760837376] 'applied index is now lower than readState.Index'  (duration: 1.839477ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:42.782703Z","caller":"traceutil/trace.go:171","msg":"trace[1473295930] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"286.31334ms","start":"2026-04-08T06:35:42.496324Z","end":"2026-04-08T06:35:42.782637Z","steps":["trace[1473295930] 'process raft request'  (duration: 285.255569ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:42.782835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.606442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"warn","ts":"2026-04-08T06:35:42.782891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.272507ms","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-04-08T06:35:42.782963Z","caller":"traceutil/trace.go:171","msg":"trace[20933028] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25190; }","duration":"150.798656ms","start":"2026-04-08T06:35:42.63214Z","end":"2026-04-08T06:35:42.782938Z","steps":["trace[20933028] 'agreement among raft nodes before linearized reading'  (duration: 150.424419ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:42.783016Z","caller":"traceutil/trace.go:171","msg":"trace[1419677917] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25190; }","duration":"219.468721ms","start":"2026-04-08T06:35:42.563525Z","end":"2026-04-08T06:35:42.782993Z","steps":["trace[1419677917] 'agreement among raft nodes before linearized reading'  (duration: 219.017932ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:43.131505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.71786ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975121958 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:25047 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-08T06:35:43.131742Z","caller":"traceutil/trace.go:171","msg":"trace[72806781] transaction","detail":"{read_only:false; response_revision:25192; number_of_response:1; }","duration":"344.13457ms","start":"2026-04-08T06:35:42.787564Z","end":"2026-04-08T06:35:43.131698Z","steps":["trace[72806781] 'process raft request'  (duration: 144.050153ms)","trace[72806781] 'compare'  (duration: 199.494366ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:43.131818Z","caller":"traceutil/trace.go:171","msg":"trace[1521644915] transaction","detail":"{read_only:false; response_revision:25193; number_of_response:1; }","duration":"305.602704ms","start":"2026-04-08T06:35:42.826181Z","end":"2026-04-08T06:35:43.131784Z","steps":["trace[1521644915] 'process raft request'  (duration: 305.505982ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:43.13189Z","caller":"traceutil/trace.go:171","msg":"trace[668815582] linearizableReadLoop","detail":"{readStateIndex:26015; appliedIndex:26014; }","duration":"313.284707ms","start":"2026-04-08T06:35:42.818565Z","end":"2026-04-08T06:35:43.131849Z","steps":["trace[668815582] 'read index received'  (duration: 113.028686ms)","trace[668815582] 'applied index is now lower than readState.Index'  (duration: 200.252611ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:43.131936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:42.826157Z","time spent":"305.724177ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"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:25173 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-04-08T06:35:43.131964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:42.787547Z","time spent":"344.292393ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:25047 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"warn","ts":"2026-04-08T06:35:43.132259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.645664ms","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-04-08T06:35:43.132352Z","caller":"traceutil/trace.go:171","msg":"trace[1135123897] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25193; }","duration":"313.791926ms","start":"2026-04-08T06:35:42.818533Z","end":"2026-04-08T06:35:43.132325Z","steps":["trace[1135123897] 'agreement among raft nodes before linearized reading'  (duration: 313.396129ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:43.13244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:42.818517Z","time spent":"313.912588ms","remote":"127.0.0.1:37592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"info","ts":"2026-04-08T06:35:43.159978Z","caller":"traceutil/trace.go:171","msg":"trace[1353343454] transaction","detail":"{read_only:false; response_revision:25195; number_of_response:1; }","duration":"193.174799ms","start":"2026-04-08T06:35:42.966768Z","end":"2026-04-08T06:35:43.159943Z","steps":["trace[1353343454] 'process raft request'  (duration: 193.080448ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:43.159981Z","caller":"traceutil/trace.go:171","msg":"trace[1513147096] transaction","detail":"{read_only:false; response_revision:25194; number_of_response:1; }","duration":"194.389293ms","start":"2026-04-08T06:35:42.965546Z","end":"2026-04-08T06:35:43.159935Z","steps":["trace[1513147096] 'process raft request'  (duration: 194.183939ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:43.160084Z","caller":"traceutil/trace.go:171","msg":"trace[129248632] transaction","detail":"{read_only:false; response_revision:25196; number_of_response:1; }","duration":"189.771292ms","start":"2026-04-08T06:35:42.970279Z","end":"2026-04-08T06:35:43.16005Z","steps":["trace[129248632] 'process raft request'  (duration: 189.603048ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:43.160245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.511398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"warn","ts":"2026-04-08T06:35:43.160333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.964393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-08T06:35:43.16034Z","caller":"traceutil/trace.go:171","msg":"trace[1280736926] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25197; }","duration":"338.635341ms","start":"2026-04-08T06:35:42.821694Z","end":"2026-04-08T06:35:43.160329Z","steps":["trace[1280736926] 'agreement among raft nodes before linearized reading'  (duration: 338.490698ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:43.16033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.038751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:43.160375Z","caller":"traceutil/trace.go:171","msg":"trace[1245611801] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:25197; }","duration":"206.050325ms","start":"2026-04-08T06:35:42.954311Z","end":"2026-04-08T06:35:43.160362Z","steps":["trace[1245611801] 'agreement among raft nodes before linearized reading'  (duration: 205.945223ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:43.160403Z","caller":"traceutil/trace.go:171","msg":"trace[1996109111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25197; }","duration":"234.159584ms","start":"2026-04-08T06:35:42.926223Z","end":"2026-04-08T06:35:43.160383Z","steps":["trace[1996109111] 'agreement among raft nodes before linearized reading'  (duration: 234.045282ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:43.160466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:35:42.821685Z","time spent":"338.684082ms","remote":"127.0.0.1:37496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"info","ts":"2026-04-08T06:35:43.160575Z","caller":"traceutil/trace.go:171","msg":"trace[560097167] transaction","detail":"{read_only:false; response_revision:25197; number_of_response:1; }","duration":"188.478406ms","start":"2026-04-08T06:35:42.972086Z","end":"2026-04-08T06:35:43.160564Z","steps":["trace[560097167] 'process raft request'  (duration: 187.822983ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:43.385221Z","caller":"traceutil/trace.go:171","msg":"trace[589025215] transaction","detail":"{read_only:false; response_revision:25200; number_of_response:1; }","duration":"103.899045ms","start":"2026-04-08T06:35:43.281288Z","end":"2026-04-08T06:35:43.385187Z","steps":["trace[589025215] 'process raft request'  (duration: 103.767752ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:43.385338Z","caller":"traceutil/trace.go:171","msg":"trace[261966806] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"106.891334ms","start":"2026-04-08T06:35:43.278407Z","end":"2026-04-08T06:35:43.385298Z","steps":["trace[261966806] 'process raft request'  (duration: 84.108441ms)","trace[261966806] 'compare'  (duration: 22.340034ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:43.385529Z","caller":"traceutil/trace.go:171","msg":"trace[1624709963] transaction","detail":"{read_only:false; response_revision:25201; number_of_response:1; }","duration":"104.045218ms","start":"2026-04-08T06:35:43.281463Z","end":"2026-04-08T06:35:43.385508Z","steps":["trace[1624709963] 'process raft request'  (duration: 103.668001ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:47.283709Z","caller":"traceutil/trace.go:171","msg":"trace[2136943117] transaction","detail":"{read_only:false; response_revision:25227; number_of_response:1; }","duration":"112.783142ms","start":"2026-04-08T06:35:47.170893Z","end":"2026-04-08T06:35:47.283676Z","steps":["trace[2136943117] 'process raft request'  (duration: 112.508546ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:47.283719Z","caller":"traceutil/trace.go:171","msg":"trace[665742087] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"111.636379ms","start":"2026-04-08T06:35:47.17205Z","end":"2026-04-08T06:35:47.283686Z","steps":["trace[665742087] 'process raft request'  (duration: 111.528617ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:47.283992Z","caller":"traceutil/trace.go:171","msg":"trace[1163683181] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"107.303752ms","start":"2026-04-08T06:35:47.176679Z","end":"2026-04-08T06:35:47.283983Z","steps":["trace[1163683181] 'process raft request'  (duration: 106.953836ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:47.284061Z","caller":"traceutil/trace.go:171","msg":"trace[902521998] transaction","detail":"{read_only:false; response_revision:25230; number_of_response:1; }","duration":"105.156389ms","start":"2026-04-08T06:35:47.178872Z","end":"2026-04-08T06:35:47.284028Z","steps":["trace[902521998] 'process raft request'  (duration: 105.008467ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:48.786874Z","caller":"traceutil/trace.go:171","msg":"trace[326528757] transaction","detail":"{read_only:false; response_revision:25239; number_of_response:1; }","duration":"115.085518ms","start":"2026-04-08T06:35:48.671765Z","end":"2026-04-08T06:35:48.786851Z","steps":["trace[326528757] 'process raft request'  (duration: 114.416454ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:48.917692Z","caller":"traceutil/trace.go:171","msg":"trace[430900038] transaction","detail":"{read_only:false; response_revision:25240; number_of_response:1; }","duration":"112.428045ms","start":"2026-04-08T06:35:48.805232Z","end":"2026-04-08T06:35:48.91766Z","steps":["trace[430900038] 'process raft request'  (duration: 109.294192ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:52.600054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.578586ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415871927975122128 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:2f679d6ba12f94cf>","response":"size:41"}
{"level":"info","ts":"2026-04-08T06:35:52.600156Z","caller":"traceutil/trace.go:171","msg":"trace[508492801] linearizableReadLoop","detail":"{readStateIndex:26091; appliedIndex:26090; }","duration":"137.294889ms","start":"2026-04-08T06:35:52.462843Z","end":"2026-04-08T06:35:52.600138Z","steps":["trace[508492801] 'read index received'  (duration: 6.451368ms)","trace[508492801] 'applied index is now lower than readState.Index'  (duration: 130.842181ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T06:35:52.600352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.505943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10851"}
{"level":"info","ts":"2026-04-08T06:35:52.600377Z","caller":"traceutil/trace.go:171","msg":"trace[1077604048] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25266; }","duration":"137.603965ms","start":"2026-04-08T06:35:52.462766Z","end":"2026-04-08T06:35:52.60037Z","steps":["trace[1077604048] 'agreement among raft nodes before linearized reading'  (duration: 137.433131ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:52.701705Z","caller":"traceutil/trace.go:171","msg":"trace[1982155206] linearizableReadLoop","detail":"{readStateIndex:26092; appliedIndex:26091; }","duration":"101.495797ms","start":"2026-04-08T06:35:52.600174Z","end":"2026-04-08T06:35:52.70167Z","steps":["trace[1982155206] 'read index received'  (duration: 99.613129ms)","trace[1982155206] 'applied index is now lower than readState.Index'  (duration: 1.881038ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:52.701871Z","caller":"traceutil/trace.go:171","msg":"trace[1220937845] transaction","detail":"{read_only:false; response_revision:25267; number_of_response:1; }","duration":"178.478908ms","start":"2026-04-08T06:35:52.523353Z","end":"2026-04-08T06:35:52.701832Z","steps":["trace[1220937845] 'process raft request'  (duration: 176.368296ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:52.702038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.425249ms","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-04-08T06:35:52.702086Z","caller":"traceutil/trace.go:171","msg":"trace[22640892] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25267; }","duration":"234.513682ms","start":"2026-04-08T06:35:52.467558Z","end":"2026-04-08T06:35:52.702072Z","steps":["trace[22640892] 'agreement among raft nodes before linearized reading'  (duration: 234.264207ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:52.707405Z","caller":"traceutil/trace.go:171","msg":"trace[683621326] transaction","detail":"{read_only:false; response_revision:25268; number_of_response:1; }","duration":"105.987397ms","start":"2026-04-08T06:35:52.601382Z","end":"2026-04-08T06:35:52.70737Z","steps":["trace[683621326] 'process raft request'  (duration: 105.699481ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:58.538293Z","caller":"traceutil/trace.go:171","msg":"trace[842195649] transaction","detail":"{read_only:false; response_revision:25324; number_of_response:1; }","duration":"117.064726ms","start":"2026-04-08T06:35:58.421199Z","end":"2026-04-08T06:35:58.538264Z","steps":["trace[842195649] 'process raft request'  (duration: 116.901783ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:58.869313Z","caller":"traceutil/trace.go:171","msg":"trace[1187761368] transaction","detail":"{read_only:false; response_revision:25325; number_of_response:1; }","duration":"143.755097ms","start":"2026-04-08T06:35:58.72554Z","end":"2026-04-08T06:35:58.869295Z","steps":["trace[1187761368] 'process raft request'  (duration: 143.615125ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:58.9027Z","caller":"traceutil/trace.go:171","msg":"trace[85916219] transaction","detail":"{read_only:false; response_revision:25326; number_of_response:1; }","duration":"102.237322ms","start":"2026-04-08T06:35:58.800453Z","end":"2026-04-08T06:35:58.90269Z","steps":["trace[85916219] 'process raft request'  (duration: 102.180161ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:59.06536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.271817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:59.065475Z","caller":"traceutil/trace.go:171","msg":"trace[864036384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25326; }","duration":"140.465961ms","start":"2026-04-08T06:35:58.924986Z","end":"2026-04-08T06:35:59.065452Z","steps":["trace[864036384] 'range keys from in-memory index tree'  (duration: 140.137415ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.065567Z","caller":"traceutil/trace.go:171","msg":"trace[570822402] transaction","detail":"{read_only:false; response_revision:25327; number_of_response:1; }","duration":"107.787523ms","start":"2026-04-08T06:35:58.957741Z","end":"2026-04-08T06:35:59.065529Z","steps":["trace[570822402] 'process raft request'  (duration: 104.892735ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.4305Z","caller":"traceutil/trace.go:171","msg":"trace[872858382] transaction","detail":"{read_only:false; response_revision:25328; number_of_response:1; }","duration":"144.472162ms","start":"2026-04-08T06:35:59.285996Z","end":"2026-04-08T06:35:59.430468Z","steps":["trace[872858382] 'process raft request'  (duration: 144.237297ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.550937Z","caller":"traceutil/trace.go:171","msg":"trace[1667642772] transaction","detail":"{read_only:false; response_revision:25329; number_of_response:1; }","duration":"217.647516ms","start":"2026-04-08T06:35:59.333257Z","end":"2026-04-08T06:35:59.550905Z","steps":["trace[1667642772] 'process raft request'  (duration: 217.398431ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.551241Z","caller":"traceutil/trace.go:171","msg":"trace[464702247] transaction","detail":"{read_only:false; response_revision:25330; number_of_response:1; }","duration":"216.095495ms","start":"2026-04-08T06:35:59.335114Z","end":"2026-04-08T06:35:59.55121Z","steps":["trace[464702247] 'process raft request'  (duration: 215.724988ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.551332Z","caller":"traceutil/trace.go:171","msg":"trace[969634152] linearizableReadLoop","detail":"{readStateIndex:26158; appliedIndex:26153; }","duration":"174.831874ms","start":"2026-04-08T06:35:59.376481Z","end":"2026-04-08T06:35:59.551313Z","steps":["trace[969634152] 'read index received'  (duration: 53.742978ms)","trace[969634152] 'applied index is now lower than readState.Index'  (duration: 121.087376ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:59.551488Z","caller":"traceutil/trace.go:171","msg":"trace[765979602] transaction","detail":"{read_only:false; response_revision:25332; number_of_response:1; }","duration":"200.075196ms","start":"2026-04-08T06:35:59.351392Z","end":"2026-04-08T06:35:59.551468Z","steps":["trace[765979602] 'process raft request'  (duration: 199.847002ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:59.5515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.004087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-08T06:35:59.551468Z","caller":"traceutil/trace.go:171","msg":"trace[2052435497] transaction","detail":"{read_only:false; response_revision:25331; number_of_response:1; }","duration":"208.425362ms","start":"2026-04-08T06:35:59.342978Z","end":"2026-04-08T06:35:59.551404Z","steps":["trace[2052435497] 'process raft request'  (duration: 208.131426ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.551545Z","caller":"traceutil/trace.go:171","msg":"trace[1017068310] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:25332; }","duration":"175.12347ms","start":"2026-04-08T06:35:59.376404Z","end":"2026-04-08T06:35:59.551528Z","steps":["trace[1017068310] 'agreement among raft nodes before linearized reading'  (duration: 174.980897ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:59.5519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.788775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-04-08T06:35:59.552007Z","caller":"traceutil/trace.go:171","msg":"trace[2014047833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25333; }","duration":"163.971068ms","start":"2026-04-08T06:35:59.388011Z","end":"2026-04-08T06:35:59.551982Z","steps":["trace[2014047833] 'agreement among raft nodes before linearized reading'  (duration: 163.665932ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.717644Z","caller":"traceutil/trace.go:171","msg":"trace[894056357] transaction","detail":"{read_only:false; response_revision:25335; number_of_response:1; }","duration":"158.627972ms","start":"2026-04-08T06:35:59.558983Z","end":"2026-04-08T06:35:59.717611Z","steps":["trace[894056357] 'process raft request'  (duration: 158.380407ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.718093Z","caller":"traceutil/trace.go:171","msg":"trace[1854149943] transaction","detail":"{read_only:false; response_revision:25336; number_of_response:1; }","duration":"158.98762ms","start":"2026-04-08T06:35:59.55907Z","end":"2026-04-08T06:35:59.718057Z","steps":["trace[1854149943] 'process raft request'  (duration: 158.488429ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.718291Z","caller":"traceutil/trace.go:171","msg":"trace[1921318454] linearizableReadLoop","detail":"{readStateIndex:26164; appliedIndex:26159; }","duration":"158.583532ms","start":"2026-04-08T06:35:59.559693Z","end":"2026-04-08T06:35:59.718276Z","steps":["trace[1921318454] 'read index received'  (duration: 25.435625ms)","trace[1921318454] 'applied index is now lower than readState.Index'  (duration: 133.147117ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:35:59.718304Z","caller":"traceutil/trace.go:171","msg":"trace[1150918511] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"158.635163ms","start":"2026-04-08T06:35:59.559655Z","end":"2026-04-08T06:35:59.71829Z","steps":["trace[1150918511] 'process raft request'  (duration: 158.558152ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:35:59.718329Z","caller":"traceutil/trace.go:171","msg":"trace[197281218] transaction","detail":"{read_only:false; response_revision:25337; number_of_response:1; }","duration":"158.980009ms","start":"2026-04-08T06:35:59.559311Z","end":"2026-04-08T06:35:59.718291Z","steps":["trace[197281218] 'process raft request'  (duration: 158.618572ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:35:59.718523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.813577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18542"}
{"level":"info","ts":"2026-04-08T06:35:59.718556Z","caller":"traceutil/trace.go:171","msg":"trace[142981225] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25338; }","duration":"158.884807ms","start":"2026-04-08T06:35:59.559661Z","end":"2026-04-08T06:35:59.718546Z","steps":["trace[142981225] 'agreement among raft nodes before linearized reading'  (duration: 158.722024ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:03.753097Z","caller":"traceutil/trace.go:171","msg":"trace[1927112830] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"184.618529ms","start":"2026-04-08T06:36:03.568448Z","end":"2026-04-08T06:36:03.753066Z","steps":["trace[1927112830] 'process raft request'  (duration: 97.035509ms)","trace[1927112830] 'compare'  (duration: 87.236913ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:36:03.788196Z","caller":"traceutil/trace.go:171","msg":"trace[339870479] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"219.588016ms","start":"2026-04-08T06:36:03.568583Z","end":"2026-04-08T06:36:03.788171Z","steps":["trace[339870479] 'process raft request'  (duration: 219.302519ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:03.788243Z","caller":"traceutil/trace.go:171","msg":"trace[2001049452] transaction","detail":"{read_only:false; response_revision:25359; number_of_response:1; }","duration":"219.577795ms","start":"2026-04-08T06:36:03.568637Z","end":"2026-04-08T06:36:03.788214Z","steps":["trace[2001049452] 'process raft request'  (duration: 219.415152ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:03.788186Z","caller":"traceutil/trace.go:171","msg":"trace[541297792] linearizableReadLoop","detail":"{readStateIndex:26187; appliedIndex:26183; }","duration":"189.312203ms","start":"2026-04-08T06:36:03.598842Z","end":"2026-04-08T06:36:03.788154Z","steps":["trace[541297792] 'read index received'  (duration: 66.691806ms)","trace[541297792] 'applied index is now lower than readState.Index'  (duration: 122.618957ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:36:03.788368Z","caller":"traceutil/trace.go:171","msg":"trace[172887518] transaction","detail":"{read_only:false; response_revision:25360; number_of_response:1; }","duration":"219.181717ms","start":"2026-04-08T06:36:03.56916Z","end":"2026-04-08T06:36:03.788342Z","steps":["trace[172887518] 'process raft request'  (duration: 218.940982ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:36:03.788502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.646159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-08T06:36:03.788575Z","caller":"traceutil/trace.go:171","msg":"trace[1460004286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25360; }","duration":"189.777802ms","start":"2026-04-08T06:36:03.598787Z","end":"2026-04-08T06:36:03.788565Z","steps":["trace[1460004286] 'agreement among raft nodes before linearized reading'  (duration: 189.576818ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:03.998608Z","caller":"traceutil/trace.go:171","msg":"trace[67139062] transaction","detail":"{read_only:false; response_revision:25362; number_of_response:1; }","duration":"205.125147ms","start":"2026-04-08T06:36:03.793459Z","end":"2026-04-08T06:36:03.998584Z","steps":["trace[67139062] 'process raft request'  (duration: 186.281603ms)","trace[67139062] 'compare'  (duration: 18.666511ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:36:03.998906Z","caller":"traceutil/trace.go:171","msg":"trace[566131427] transaction","detail":"{read_only:false; response_revision:25363; number_of_response:1; }","duration":"205.237149ms","start":"2026-04-08T06:36:03.793633Z","end":"2026-04-08T06:36:03.99887Z","steps":["trace[566131427] 'process raft request'  (duration: 204.896882ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:03.999136Z","caller":"traceutil/trace.go:171","msg":"trace[4484795] transaction","detail":"{read_only:false; response_revision:25364; number_of_response:1; }","duration":"205.435023ms","start":"2026-04-08T06:36:03.793673Z","end":"2026-04-08T06:36:03.999108Z","steps":["trace[4484795] 'process raft request'  (duration: 205.090816ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:03.999235Z","caller":"traceutil/trace.go:171","msg":"trace[544482750] transaction","detail":"{read_only:false; response_revision:25365; number_of_response:1; }","duration":"205.474974ms","start":"2026-04-08T06:36:03.793737Z","end":"2026-04-08T06:36:03.999212Z","steps":["trace[544482750] 'process raft request'  (duration: 205.29495ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:04.035484Z","caller":"traceutil/trace.go:171","msg":"trace[881249289] transaction","detail":"{read_only:false; response_revision:25366; number_of_response:1; }","duration":"127.152038ms","start":"2026-04-08T06:36:03.908296Z","end":"2026-04-08T06:36:04.035448Z","steps":["trace[881249289] 'process raft request'  (duration: 126.711989ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:25.338095Z","caller":"traceutil/trace.go:171","msg":"trace[1145672347] linearizableReadLoop","detail":"{readStateIndex:26361; appliedIndex:26360; }","duration":"107.366771ms","start":"2026-04-08T06:36:25.230683Z","end":"2026-04-08T06:36:25.338049Z","steps":["trace[1145672347] 'read index received'  (duration: 107.089556ms)","trace[1145672347] 'applied index is now lower than readState.Index'  (duration: 275.605µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T06:36:25.338196Z","caller":"traceutil/trace.go:171","msg":"trace[916014009] transaction","detail":"{read_only:false; response_revision:25529; number_of_response:1; }","duration":"155.949505ms","start":"2026-04-08T06:36:25.182187Z","end":"2026-04-08T06:36:25.338136Z","steps":["trace[916014009] 'process raft request'  (duration: 155.633779ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:36:25.338521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.766009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-08T06:36:25.338584Z","caller":"traceutil/trace.go:171","msg":"trace[227456816] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25529; }","duration":"107.936322ms","start":"2026-04-08T06:36:25.230631Z","end":"2026-04-08T06:36:25.338568Z","steps":["trace[227456816] 'agreement among raft nodes before linearized reading'  (duration: 107.564835ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T06:36:25.889588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.147022ms","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:6"}
{"level":"info","ts":"2026-04-08T06:36:25.889727Z","caller":"traceutil/trace.go:171","msg":"trace[1044472733] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:25530; }","duration":"138.350176ms","start":"2026-04-08T06:36:25.751348Z","end":"2026-04-08T06:36:25.889698Z","steps":["trace[1044472733] 'count revisions from in-memory index tree'  (duration: 138.03505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T06:36:59.35432Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22951}
{"level":"info","ts":"2026-04-08T06:36:59.489551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22951,"took":"130.456219ms","hash":3467102963,"current-db-size-bytes":59584512,"current-db-size":"60 MB","current-db-size-in-use-bytes":35459072,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-04-08T06:36:59.489667Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3467102963,"revision":22951,"compact-revision":20040}
{"level":"info","ts":"2026-04-08T06:37:21.948111Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006960.wal"}
{"level":"info","ts":"2026-04-08T06:41:59.360611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25964}
{"level":"info","ts":"2026-04-08T06:41:59.509186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25964,"took":"143.878686ms","hash":2724205682,"current-db-size-bytes":59584512,"current-db-size":"60 MB","current-db-size-in-use-bytes":34762752,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-04-08T06:41:59.509279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2724205682,"revision":25964,"compact-revision":22951}
{"level":"info","ts":"2026-04-08T06:42:54.19712Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T06:42:54.203404Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-04-08T06:42:54.203549Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-04-08T06:46:59.372205Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28677}
{"level":"info","ts":"2026-04-08T06:46:59.541102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28677,"took":"163.526674ms","hash":855022639,"current-db-size-bytes":59584512,"current-db-size":"60 MB","current-db-size-in-use-bytes":30031872,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-04-08T06:46:59.541164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":855022639,"revision":28677,"compact-revision":25964}
{"level":"info","ts":"2026-04-08T06:51:59.379513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30901}
{"level":"info","ts":"2026-04-08T06:51:59.510587Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30901,"took":"125.627514ms","hash":3782976114,"current-db-size-bytes":59584512,"current-db-size":"60 MB","current-db-size-in-use-bytes":31092736,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-04-08T06:51:59.511191Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3782976114,"revision":30901,"compact-revision":28677}
{"level":"info","ts":"2026-04-08T06:56:59.386988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33177}
{"level":"info","ts":"2026-04-08T06:56:59.541022Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33177,"took":"148.440392ms","hash":4096515105,"current-db-size-bytes":60628992,"current-db-size":"61 MB","current-db-size-in-use-bytes":31453184,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-04-08T06:56:59.541096Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4096515105,"revision":33177,"compact-revision":30901}
{"level":"info","ts":"2026-04-08T07:01:59.394143Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35477}
{"level":"info","ts":"2026-04-08T07:01:59.54836Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35477,"took":"147.289378ms","hash":1622110347,"current-db-size-bytes":62754816,"current-db-size":"63 MB","current-db-size-in-use-bytes":31588352,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-04-08T07:01:59.548452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1622110347,"revision":35477,"compact-revision":33177}
{"level":"info","ts":"2026-04-08T07:04:14.451415Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T07:04:14.458163Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-04-08T07:04:14.458287Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-04-08T07:06:59.403922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37771}
{"level":"info","ts":"2026-04-08T07:06:59.535915Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37771,"took":"128.536867ms","hash":1522613158,"current-db-size-bytes":62754816,"current-db-size":"63 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-04-08T07:06:59.536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1522613158,"revision":37771,"compact-revision":35477}