{"level":"warn","ts":"2026-04-08T22:55:39.322275Z","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-08T22:55:39.322371Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.200: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://162.253.55.200:2380","--initial-cluster=instance=https://162.253.55.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.200: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-08T22:55:39.32244Z","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-08T22:55:39.322453Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.200:2380"]}
{"level":"info","ts":"2026-04-08T22:55:39.322469Z","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-08T22:55:39.323072Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"]}
{"level":"info","ts":"2026-04-08T22:55:39.323142Z","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://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.200: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-08T22:55:39.327321Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.944768ms"}
{"level":"info","ts":"2026-04-08T22:55:39.333329Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e10bb51ed7578852","cluster-id":"aa14459abd2161c3"}
{"level":"info","ts":"2026-04-08T22:55:39.333409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-08T22:55:39.333435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 0"}
{"level":"info","ts":"2026-04-08T22:55:39.333452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e10bb51ed7578852 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-08T22:55:39.333467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 1"}
{"level":"info","ts":"2026-04-08T22:55:39.333503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"}
{"level":"warn","ts":"2026-04-08T22:55:39.340583Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-08T22:55:39.342033Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-08T22:55:39.343411Z","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-08T22:55:39.346625Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e10bb51ed7578852","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-08T22:55:39.34716Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e10bb51ed7578852","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-08T22:55:39.347422Z","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-08T22:55:39.347463Z","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-08T22:55:39.347476Z","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-08T22:55:39.347964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"}
{"level":"info","ts":"2026-04-08T22:55:39.349841Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","added-peer-id":"e10bb51ed7578852","added-peer-peer-urls":["https://162.253.55.200:2380"]}
{"level":"info","ts":"2026-04-08T22:55:39.352658Z","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-08T22:55:39.352856Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.200:2380"}
{"level":"info","ts":"2026-04-08T22:55:39.353483Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.200:2380"}
{"level":"info","ts":"2026-04-08T22:55:39.35477Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e10bb51ed7578852","initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-08T22:55:39.354828Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-08T22:55:39.733697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-08T22:55:39.733753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-08T22:55:39.733781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgPreVoteResp from e10bb51ed7578852 at term 1"}
{"level":"info","ts":"2026-04-08T22:55:39.733796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became candidate at term 2"}
{"level":"info","ts":"2026-04-08T22:55:39.733802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgVoteResp from e10bb51ed7578852 at term 2"}
{"level":"info","ts":"2026-04-08T22:55:39.733813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became leader at term 2"}
{"level":"info","ts":"2026-04-08T22:55:39.733822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e10bb51ed7578852 elected leader e10bb51ed7578852 at term 2"}
{"level":"info","ts":"2026-04-08T22:55:39.734667Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T22:55:39.735478Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e10bb51ed7578852","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.200:2379]}","request-path":"/0/members/e10bb51ed7578852/attributes","cluster-id":"aa14459abd2161c3","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-08T22:55:39.73553Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T22:55:39.735957Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T22:55:39.73599Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T22:55:39.736087Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T22:55:39.736117Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T22:55:39.736488Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-08T22:55:39.736549Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-08T22:55:39.738757Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-08T22:55:39.740886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.200:2379"}
{"level":"info","ts":"2026-04-08T22:56:16.600134Z","caller":"traceutil/trace.go:171","msg":"trace[2032744964] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"269.972862ms","start":"2026-04-08T22:56:16.330123Z","end":"2026-04-08T22:56:16.600096Z","steps":["trace[2032744964] 'process raft request'  (duration: 268.916138ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:56:17.087507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.282782ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640232931 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-08T22:56:17.087659Z","caller":"traceutil/trace.go:171","msg":"trace[501177235] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"290.242793ms","start":"2026-04-08T22:56:16.7974Z","end":"2026-04-08T22:56:17.087643Z","steps":["trace[501177235] 'read index received'  (duration: 165.306187ms)","trace[501177235] 'applied index is now lower than readState.Index'  (duration: 124.935406ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T22:56:17.087717Z","caller":"traceutil/trace.go:171","msg":"trace[308394711] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"428.203934ms","start":"2026-04-08T22:56:16.659441Z","end":"2026-04-08T22:56:17.087645Z","steps":["trace[308394711] 'process raft request'  (duration: 303.263728ms)","trace[308394711] 'compare'  (duration: 124.134518ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T22:56:17.087883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:56:16.659409Z","time spent":"428.406379ms","remote":"127.0.0.1:54262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-04-08T22:56:17.088068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.632182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wxvwl\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-08T22:56:17.088183Z","caller":"traceutil/trace.go:171","msg":"trace[1695926077] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wxvwl; range_end:; response_count:1; response_revision:581; }","duration":"290.831978ms","start":"2026-04-08T22:56:16.797325Z","end":"2026-04-08T22:56:17.088157Z","steps":["trace[1695926077] 'agreement among raft nodes before linearized reading'  (duration: 290.389587ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:56:17.335476Z","caller":"traceutil/trace.go:171","msg":"trace[1392788466] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"126.451303ms","start":"2026-04-08T22:56:17.209003Z","end":"2026-04-08T22:56:17.335454Z","steps":["trace[1392788466] 'read index received'  (duration: 122.05547ms)","trace[1392788466] 'applied index is now lower than readState.Index'  (duration: 4.395123ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T22:56:17.335533Z","caller":"traceutil/trace.go:171","msg":"trace[681117787] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"229.384048ms","start":"2026-04-08T22:56:17.106125Z","end":"2026-04-08T22:56:17.335509Z","steps":["trace[681117787] 'process raft request'  (duration: 224.879303ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:56:17.335715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.706518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T22:56:17.335873Z","caller":"traceutil/trace.go:171","msg":"trace[553203496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"126.943073ms","start":"2026-04-08T22:56:17.208886Z","end":"2026-04-08T22:56:17.335829Z","steps":["trace[553203496] 'agreement among raft nodes before linearized reading'  (duration: 126.668797ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:56:33.596421Z","caller":"traceutil/trace.go:171","msg":"trace[1537399458] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"129.108614ms","start":"2026-04-08T22:56:33.46728Z","end":"2026-04-08T22:56:33.596389Z","steps":["trace[1537399458] 'read index received'  (duration: 128.93207ms)","trace[1537399458] 'applied index is now lower than readState.Index'  (duration: 174.874µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T22:56:33.596479Z","caller":"traceutil/trace.go:171","msg":"trace[1799644683] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"163.261209ms","start":"2026-04-08T22:56:33.433171Z","end":"2026-04-08T22:56:33.596433Z","steps":["trace[1799644683] 'process raft request'  (duration: 162.984433ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:56:33.596734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.425782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-08T22:56:33.596784Z","caller":"traceutil/trace.go:171","msg":"trace[2067433199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:751; }","duration":"129.522235ms","start":"2026-04-08T22:56:33.467249Z","end":"2026-04-08T22:56:33.596771Z","steps":["trace[2067433199] 'agreement among raft nodes before linearized reading'  (duration: 129.319059ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:56:33.596862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.501914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-04-08T22:56:33.597Z","caller":"traceutil/trace.go:171","msg":"trace[2004659015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:751; }","duration":"126.673768ms","start":"2026-04-08T22:56:33.470303Z","end":"2026-04-08T22:56:33.596976Z","steps":["trace[2004659015] 'agreement among raft nodes before linearized reading'  (duration: 126.400612ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:56:33.596899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.161453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-08T22:56:33.597139Z","caller":"traceutil/trace.go:171","msg":"trace[1457759538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"128.428818ms","start":"2026-04-08T22:56:33.468679Z","end":"2026-04-08T22:56:33.597108Z","steps":["trace[1457759538] 'agreement among raft nodes before linearized reading'  (duration: 127.969488ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:56:59.915016Z","caller":"traceutil/trace.go:171","msg":"trace[620682091] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"137.178662ms","start":"2026-04-08T22:56:59.777797Z","end":"2026-04-08T22:56:59.914975Z","steps":["trace[620682091] 'process raft request'  (duration: 136.919246ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:56:59.925396Z","caller":"traceutil/trace.go:171","msg":"trace[1838718565] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"146.574211ms","start":"2026-04-08T22:56:59.778794Z","end":"2026-04-08T22:56:59.925369Z","steps":["trace[1838718565] 'process raft request'  (duration: 146.493719ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:56:59.925452Z","caller":"traceutil/trace.go:171","msg":"trace[545286953] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"147.146773ms","start":"2026-04-08T22:56:59.778258Z","end":"2026-04-08T22:56:59.925404Z","steps":["trace[545286953] 'process raft request'  (duration: 146.862787ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:56:59.925509Z","caller":"traceutil/trace.go:171","msg":"trace[217565099] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"145.557187ms","start":"2026-04-08T22:56:59.779938Z","end":"2026-04-08T22:56:59.925495Z","steps":["trace[217565099] 'process raft request'  (duration: 145.393014ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:57:44.828467Z","caller":"traceutil/trace.go:171","msg":"trace[1409101076] linearizableReadLoop","detail":"{readStateIndex:1865; appliedIndex:1864; }","duration":"489.28435ms","start":"2026-04-08T22:57:44.33916Z","end":"2026-04-08T22:57:44.828444Z","steps":["trace[1409101076] 'read index received'  (duration: 489.24908ms)","trace[1409101076] 'applied index is now lower than readState.Index'  (duration: 33.74µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T22:57:44.828585Z","caller":"traceutil/trace.go:171","msg":"trace[1097043965] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"506.196307ms","start":"2026-04-08T22:57:44.322314Z","end":"2026-04-08T22:57:44.82851Z","steps":["trace[1097043965] 'process raft request'  (duration: 505.978692ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:57:44.828666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.043613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05c79555-785e-4ef5-8555-c91e0fa041c7\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-04-08T22:57:44.828715Z","caller":"traceutil/trace.go:171","msg":"trace[385319391] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-05c79555-785e-4ef5-8555-c91e0fa041c7; range_end:; response_count:1; response_revision:1799; }","duration":"148.136045ms","start":"2026-04-08T22:57:44.680565Z","end":"2026-04-08T22:57:44.828701Z","steps":["trace[385319391] 'agreement among raft nodes before linearized reading'  (duration: 148.039023ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:57:44.828816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.610178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-04-08T22:57:44.828967Z","caller":"traceutil/trace.go:171","msg":"trace[1778147723] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1799; }","duration":"489.754221ms","start":"2026-04-08T22:57:44.339155Z","end":"2026-04-08T22:57:44.828909Z","steps":["trace[1778147723] 'agreement among raft nodes before linearized reading'  (duration: 489.437164ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:57:44.828964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:44.322288Z","time spent":"506.37274ms","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05c79555-785e-4ef5-8555-c91e0fa041c7\" mod_revision:1750 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05c79555-785e-4ef5-8555-c91e0fa041c7\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05c79555-785e-4ef5-8555-c91e0fa041c7\" > >"}
{"level":"warn","ts":"2026-04-08T22:57:44.829029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:44.339117Z","time spent":"489.902364ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-08T22:57:44.958597Z","caller":"traceutil/trace.go:171","msg":"trace[1091363843] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"124.534265ms","start":"2026-04-08T22:57:44.83403Z","end":"2026-04-08T22:57:44.958565Z","steps":["trace[1091363843] 'process raft request'  (duration: 90.291913ms)","trace[1091363843] 'compare'  (duration: 34.052928ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T22:57:45.326449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.979263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T22:57:45.326516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.829377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-08T22:57:45.326556Z","caller":"traceutil/trace.go:171","msg":"trace[1762641460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1801; }","duration":"117.133677ms","start":"2026-04-08T22:57:45.209395Z","end":"2026-04-08T22:57:45.326529Z","steps":["trace[1762641460] 'range keys from in-memory index tree'  (duration: 116.867011ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:57:45.326567Z","caller":"traceutil/trace.go:171","msg":"trace[1996118324] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1801; }","duration":"213.909178ms","start":"2026-04-08T22:57:45.112643Z","end":"2026-04-08T22:57:45.326552Z","steps":["trace[1996118324] 'range keys from in-memory index tree'  (duration: 213.616192ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:57:45.326649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.087925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-08T22:57:45.326741Z","caller":"traceutil/trace.go:171","msg":"trace[567711661] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1801; }","duration":"261.26098ms","start":"2026-04-08T22:57:45.065459Z","end":"2026-04-08T22:57:45.32672Z","steps":["trace[567711661] 'range keys from in-memory index tree'  (duration: 260.725707ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:58:30.570765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.178776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-08T22:58:30.570966Z","caller":"traceutil/trace.go:171","msg":"trace[160725946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2101; }","duration":"187.724509ms","start":"2026-04-08T22:58:30.38322Z","end":"2026-04-08T22:58:30.570945Z","steps":["trace[160725946] 'range keys from in-memory index tree'  (duration: 186.984212ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:58:30.570852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.041947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-08T22:58:30.571276Z","caller":"traceutil/trace.go:171","msg":"trace[1573580992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2101; }","duration":"188.532108ms","start":"2026-04-08T22:58:30.382731Z","end":"2026-04-08T22:58:30.571263Z","steps":["trace[1573580992] 'range keys from in-memory index tree'  (duration: 187.75119ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:58:30.862894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.858387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-08T22:58:30.863031Z","caller":"traceutil/trace.go:171","msg":"trace[1691196897] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2105; }","duration":"182.047731ms","start":"2026-04-08T22:58:30.680959Z","end":"2026-04-08T22:58:30.863007Z","steps":["trace[1691196897] 'range keys from in-memory index tree'  (duration: 181.456348ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:58:31.057855Z","caller":"traceutil/trace.go:171","msg":"trace[566299443] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"241.079324ms","start":"2026-04-08T22:58:30.816735Z","end":"2026-04-08T22:58:31.057814Z","steps":["trace[566299443] 'process raft request'  (duration: 240.819358ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:58:31.400283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.649297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"warn","ts":"2026-04-08T22:58:31.400356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.509595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T22:58:31.400398Z","caller":"traceutil/trace.go:171","msg":"trace[1127943034] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2106; }","duration":"144.77654ms","start":"2026-04-08T22:58:31.255592Z","end":"2026-04-08T22:58:31.400368Z","steps":["trace[1127943034] 'range keys from in-memory index tree'  (duration: 144.380651ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:58:31.400464Z","caller":"traceutil/trace.go:171","msg":"trace[1963271762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"191.698439ms","start":"2026-04-08T22:58:31.208738Z","end":"2026-04-08T22:58:31.400436Z","steps":["trace[1963271762] 'range keys from in-memory index tree'  (duration: 191.373352ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:59:54.040506Z","caller":"traceutil/trace.go:171","msg":"trace[2123656517] transaction","detail":"{read_only:false; response_revision:2605; number_of_response:1; }","duration":"103.131447ms","start":"2026-04-08T22:59:53.93733Z","end":"2026-04-08T22:59:54.040461Z","steps":["trace[2123656517] 'process raft request'  (duration: 102.840219ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:59:54.226649Z","caller":"traceutil/trace.go:171","msg":"trace[567118243] transaction","detail":"{read_only:false; response_revision:2606; number_of_response:1; }","duration":"180.77275ms","start":"2026-04-08T22:59:54.045842Z","end":"2026-04-08T22:59:54.226615Z","steps":["trace[567118243] 'process raft request'  (duration: 160.950695ms)","trace[567118243] 'compare'  (duration: 19.650861ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T22:59:54.235476Z","caller":"traceutil/trace.go:171","msg":"trace[818033533] transaction","detail":"{read_only:false; response_revision:2608; number_of_response:1; }","duration":"188.932353ms","start":"2026-04-08T22:59:54.046516Z","end":"2026-04-08T22:59:54.235448Z","steps":["trace[818033533] 'process raft request'  (duration: 188.874312ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T22:59:54.235517Z","caller":"traceutil/trace.go:171","msg":"trace[710273820] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"189.106606ms","start":"2026-04-08T22:59:54.046391Z","end":"2026-04-08T22:59:54.235498Z","steps":["trace[710273820] 'process raft request'  (duration: 188.84682ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T22:59:54.695463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.321509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T22:59:54.695668Z","caller":"traceutil/trace.go:171","msg":"trace[539013155] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2608; }","duration":"233.585235ms","start":"2026-04-08T22:59:54.462055Z","end":"2026-04-08T22:59:54.69564Z","steps":["trace[539013155] 'count revisions from in-memory index tree'  (duration: 233.219067ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:03:52.332406Z","caller":"traceutil/trace.go:171","msg":"trace[1679461151] transaction","detail":"{read_only:false; response_revision:4508; number_of_response:1; }","duration":"202.82326ms","start":"2026-04-08T23:03:52.129554Z","end":"2026-04-08T23:03:52.332377Z","steps":["trace[1679461151] 'process raft request'  (duration: 202.653186ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:03:52.33349Z","caller":"traceutil/trace.go:171","msg":"trace[1386414596] linearizableReadLoop","detail":"{readStateIndex:4678; appliedIndex:4676; }","duration":"194.059764ms","start":"2026-04-08T23:03:52.139406Z","end":"2026-04-08T23:03:52.333466Z","steps":["trace[1386414596] 'read index received'  (duration: 192.816096ms)","trace[1386414596] 'applied index is now lower than readState.Index'  (duration: 1.242527ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:03:52.333835Z","caller":"traceutil/trace.go:171","msg":"trace[722742709] transaction","detail":"{read_only:false; response_revision:4509; number_of_response:1; }","duration":"202.872811ms","start":"2026-04-08T23:03:52.130927Z","end":"2026-04-08T23:03:52.3338Z","steps":["trace[722742709] 'process raft request'  (duration: 202.43045ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:03:52.33383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.227323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:03:52.33417Z","caller":"traceutil/trace.go:171","msg":"trace[1380462720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4509; }","duration":"125.645043ms","start":"2026-04-08T23:03:52.208512Z","end":"2026-04-08T23:03:52.334157Z","steps":["trace[1380462720] 'agreement among raft nodes before linearized reading'  (duration: 125.203163ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:03:52.333904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.579226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-04-08T23:03:52.334313Z","caller":"traceutil/trace.go:171","msg":"trace[1642073734] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4509; }","duration":"194.985914ms","start":"2026-04-08T23:03:52.139276Z","end":"2026-04-08T23:03:52.334262Z","steps":["trace[1642073734] 'agreement among raft nodes before linearized reading'  (duration: 194.462383ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:01.659779Z","caller":"traceutil/trace.go:171","msg":"trace[547012820] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"149.428275ms","start":"2026-04-08T23:04:01.51032Z","end":"2026-04-08T23:04:01.659748Z","steps":["trace[547012820] 'process raft request'  (duration: 144.655318ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:01.660253Z","caller":"traceutil/trace.go:171","msg":"trace[1042984108] linearizableReadLoop","detail":"{readStateIndex:4961; appliedIndex:4959; }","duration":"149.317572ms","start":"2026-04-08T23:04:01.510909Z","end":"2026-04-08T23:04:01.660227Z","steps":["trace[1042984108] 'read index received'  (duration: 8.593432ms)","trace[1042984108] 'applied index is now lower than readState.Index'  (duration: 140.72261ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:04:01.660509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.577138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"}
{"level":"info","ts":"2026-04-08T23:04:01.660547Z","caller":"traceutil/trace.go:171","msg":"trace[334275738] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4786; }","duration":"149.67057ms","start":"2026-04-08T23:04:01.510864Z","end":"2026-04-08T23:04:01.660534Z","steps":["trace[334275738] 'agreement among raft nodes before linearized reading'  (duration: 149.473125ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:01.6608Z","caller":"traceutil/trace.go:171","msg":"trace[1741308451] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"137.279952ms","start":"2026-04-08T23:04:01.523467Z","end":"2026-04-08T23:04:01.660747Z","steps":["trace[1741308451] 'process raft request'  (duration: 136.335372ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:01.660947Z","caller":"traceutil/trace.go:171","msg":"trace[1301971937] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"141.032197ms","start":"2026-04-08T23:04:01.519857Z","end":"2026-04-08T23:04:01.660889Z","steps":["trace[1301971937] 'process raft request'  (duration: 139.872191ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:08.887756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.568021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c69895656-rq9pk.18a484252b823e56\" ","response":"range_response_count:1 size:898"}
{"level":"info","ts":"2026-04-08T23:04:08.887863Z","caller":"traceutil/trace.go:171","msg":"trace[626502160] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7c69895656-rq9pk.18a484252b823e56; range_end:; response_count:1; response_revision:4938; }","duration":"201.718855ms","start":"2026-04-08T23:04:08.686121Z","end":"2026-04-08T23:04:08.88784Z","steps":["trace[626502160] 'range keys from in-memory index tree'  (duration: 201.394617ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:08.887876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.638221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-hlnnr\" ","response":"range_response_count:1 size:4040"}
{"level":"info","ts":"2026-04-08T23:04:08.887981Z","caller":"traceutil/trace.go:171","msg":"trace[2119819996] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-hlnnr; range_end:; response_count:1; response_revision:4938; }","duration":"213.773475ms","start":"2026-04-08T23:04:08.674184Z","end":"2026-04-08T23:04:08.887958Z","steps":["trace[2119819996] 'range keys from in-memory index tree'  (duration: 213.461817ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:08.888606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.414128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:27 size:838176"}
{"level":"info","ts":"2026-04-08T23:04:08.888688Z","caller":"traceutil/trace.go:171","msg":"trace[1101260569] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:27; response_revision:4938; }","duration":"197.51911ms","start":"2026-04-08T23:04:08.691151Z","end":"2026-04-08T23:04:08.88867Z","steps":["trace[1101260569] 'range keys from in-memory index tree'  (duration: 196.550159ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:08.889605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.029367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2366191"}
{"level":"info","ts":"2026-04-08T23:04:08.889742Z","caller":"traceutil/trace.go:171","msg":"trace[926637209] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:4938; }","duration":"213.331895ms","start":"2026-04-08T23:04:08.676383Z","end":"2026-04-08T23:04:08.889715Z","steps":["trace[926637209] 'range keys from in-memory index tree'  (duration: 211.437893ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:09.125122Z","caller":"traceutil/trace.go:171","msg":"trace[1429873471] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"168.565373ms","start":"2026-04-08T23:04:08.956531Z","end":"2026-04-08T23:04:09.125097Z","steps":["trace[1429873471] 'process raft request'  (duration: 168.373448ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:09.159494Z","caller":"traceutil/trace.go:171","msg":"trace[1036196315] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"149.594588ms","start":"2026-04-08T23:04:09.009867Z","end":"2026-04-08T23:04:09.159462Z","steps":["trace[1036196315] 'process raft request'  (duration: 149.412724ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:09.491799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.322081ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640243288 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c69895656-rq9pk.18a484252b823e56\" mod_revision:4939 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c69895656-rq9pk.18a484252b823e56\" value_size:774 lease:599714801785467265 >> failure:<request_range:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7c69895656-rq9pk.18a484252b823e56\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:04:09.491972Z","caller":"traceutil/trace.go:171","msg":"trace[392675513] linearizableReadLoop","detail":"{readStateIndex:5131; appliedIndex:5130; }","duration":"185.357179ms","start":"2026-04-08T23:04:09.306591Z","end":"2026-04-08T23:04:09.491948Z","steps":["trace[392675513] 'read index received'  (duration: 56.632478ms)","trace[392675513] 'applied index is now lower than readState.Index'  (duration: 128.723121ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:04:09.492055Z","caller":"traceutil/trace.go:171","msg":"trace[2010540322] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"187.917206ms","start":"2026-04-08T23:04:09.304099Z","end":"2026-04-08T23:04:09.492016Z","steps":["trace[2010540322] 'process raft request'  (duration: 59.238527ms)","trace[2010540322] 'compare'  (duration: 128.082465ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:04:09.492425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.776348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-04-08T23:04:09.492553Z","caller":"traceutil/trace.go:171","msg":"trace[1382165558] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4946; }","duration":"185.945472ms","start":"2026-04-08T23:04:09.306576Z","end":"2026-04-08T23:04:09.492521Z","steps":["trace[1382165558] 'agreement among raft nodes before linearized reading'  (duration: 185.544434ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:09.504476Z","caller":"traceutil/trace.go:171","msg":"trace[1144040267] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"194.736679ms","start":"2026-04-08T23:04:09.309726Z","end":"2026-04-08T23:04:09.504463Z","steps":["trace[1144040267] 'process raft request'  (duration: 194.601026ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:09.716481Z","caller":"traceutil/trace.go:171","msg":"trace[1040453131] linearizableReadLoop","detail":"{readStateIndex:5139; appliedIndex:5138; }","duration":"147.540033ms","start":"2026-04-08T23:04:09.568923Z","end":"2026-04-08T23:04:09.716463Z","steps":["trace[1040453131] 'read index received'  (duration: 61.089938ms)","trace[1040453131] 'applied index is now lower than readState.Index'  (duration: 86.448845ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:04:09.716557Z","caller":"traceutil/trace.go:171","msg":"trace[1263400215] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"152.261808ms","start":"2026-04-08T23:04:09.564264Z","end":"2026-04-08T23:04:09.716526Z","steps":["trace[1263400215] 'process raft request'  (duration: 65.846984ms)","trace[1263400215] 'compare'  (duration: 86.066547ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:04:09.716708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.972855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"}
{"level":"info","ts":"2026-04-08T23:04:09.716806Z","caller":"traceutil/trace.go:171","msg":"trace[1277155362] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4954; }","duration":"162.172309ms","start":"2026-04-08T23:04:09.554622Z","end":"2026-04-08T23:04:09.716795Z","steps":["trace[1277155362] 'agreement among raft nodes before linearized reading'  (duration: 161.936514ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:09.792967Z","caller":"traceutil/trace.go:171","msg":"trace[988302844] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"106.499273ms","start":"2026-04-08T23:04:09.686397Z","end":"2026-04-08T23:04:09.792896Z","steps":["trace[988302844] 'process raft request'  (duration: 106.249338ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:09.793067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.571581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:04:09.793725Z","caller":"traceutil/trace.go:171","msg":"trace[55422929] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4955; }","duration":"177.318559ms","start":"2026-04-08T23:04:09.616373Z","end":"2026-04-08T23:04:09.793692Z","steps":["trace[55422929] 'agreement among raft nodes before linearized reading'  (duration: 176.45954ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:09.793175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.356894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-cdd157fa-d03c-493e-bc21-f81d518a4c87\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-04-08T23:04:09.793828Z","caller":"traceutil/trace.go:171","msg":"trace[214953211] range","detail":"{range_begin:/registry/persistentvolumes/pvc-cdd157fa-d03c-493e-bc21-f81d518a4c87; range_end:; response_count:1; response_revision:4955; }","duration":"222.117171ms","start":"2026-04-08T23:04:09.571691Z","end":"2026-04-08T23:04:09.793808Z","steps":["trace[214953211] 'agreement among raft nodes before linearized reading'  (duration: 221.256792ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:14.142937Z","caller":"traceutil/trace.go:171","msg":"trace[221977367] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"131.926172ms","start":"2026-04-08T23:04:14.01097Z","end":"2026-04-08T23:04:14.142896Z","steps":["trace[221977367] 'process raft request'  (duration: 131.505093ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:22.570233Z","caller":"traceutil/trace.go:171","msg":"trace[1857076113] transaction","detail":"{read_only:false; response_revision:5168; number_of_response:1; }","duration":"132.525446ms","start":"2026-04-08T23:04:22.437679Z","end":"2026-04-08T23:04:22.570204Z","steps":["trace[1857076113] 'process raft request'  (duration: 132.353782ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:35.792222Z","caller":"traceutil/trace.go:171","msg":"trace[197607977] linearizableReadLoop","detail":"{readStateIndex:5556; appliedIndex:5555; }","duration":"134.096212ms","start":"2026-04-08T23:04:35.6581Z","end":"2026-04-08T23:04:35.792196Z","steps":["trace[197607977] 'read index received'  (duration: 133.927728ms)","trace[197607977] 'applied index is now lower than readState.Index'  (duration: 167.304µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:04:35.792322Z","caller":"traceutil/trace.go:171","msg":"trace[1594606634] transaction","detail":"{read_only:false; response_revision:5361; number_of_response:1; }","duration":"216.944467ms","start":"2026-04-08T23:04:35.57533Z","end":"2026-04-08T23:04:35.792275Z","steps":["trace[1594606634] 'process raft request'  (duration: 216.691581ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:35.792547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.393318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-04-08T23:04:35.792598Z","caller":"traceutil/trace.go:171","msg":"trace[1647982808] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5361; }","duration":"134.49189ms","start":"2026-04-08T23:04:35.658093Z","end":"2026-04-08T23:04:35.792585Z","steps":["trace[1647982808] 'agreement among raft nodes before linearized reading'  (duration: 134.248105ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:35.792596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.231183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"}
{"level":"info","ts":"2026-04-08T23:04:35.792685Z","caller":"traceutil/trace.go:171","msg":"trace[1641064128] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5361; }","duration":"100.387887ms","start":"2026-04-08T23:04:35.692275Z","end":"2026-04-08T23:04:35.792663Z","steps":["trace[1641064128] 'agreement among raft nodes before linearized reading'  (duration: 100.104481ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.275893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.294511ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640244229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5zznr\" mod_revision:5095 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5zznr\" value_size:1433 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5zznr\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:04:36.276059Z","caller":"traceutil/trace.go:171","msg":"trace[383556569] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"477.61314ms","start":"2026-04-08T23:04:35.798375Z","end":"2026-04-08T23:04:36.275988Z","steps":["trace[383556569] 'process raft request'  (duration: 127.142385ms)","trace[383556569] 'compare'  (duration: 350.173877ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:04:36.276165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.798355Z","time spent":"477.774524ms","remote":"127.0.0.1:54152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5zznr\" mod_revision:5095 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5zznr\" value_size:1433 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-5zznr\" > >"}
{"level":"info","ts":"2026-04-08T23:04:36.301037Z","caller":"traceutil/trace.go:171","msg":"trace[1428222050] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"502.335953ms","start":"2026-04-08T23:04:35.798666Z","end":"2026-04-08T23:04:36.301002Z","steps":["trace[1428222050] 'process raft request'  (duration: 502.010196ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.301257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.798634Z","time spent":"502.506328ms","remote":"127.0.0.1:54152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-csvx4\" mod_revision:5099 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-csvx4\" value_size:1362 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-csvx4\" > >"}
{"level":"info","ts":"2026-04-08T23:04:36.301297Z","caller":"traceutil/trace.go:171","msg":"trace[142488314] linearizableReadLoop","detail":"{readStateIndex:5558; appliedIndex:5556; }","duration":"502.15243ms","start":"2026-04-08T23:04:35.799126Z","end":"2026-04-08T23:04:36.301278Z","steps":["trace[142488314] 'read index received'  (duration: 126.359218ms)","trace[142488314] 'applied index is now lower than readState.Index'  (duration: 375.792082ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:04:36.301389Z","caller":"traceutil/trace.go:171","msg":"trace[446296174] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"501.735619ms","start":"2026-04-08T23:04:35.799643Z","end":"2026-04-08T23:04:36.301378Z","steps":["trace[446296174] 'process raft request'  (duration: 501.548685ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:36.301391Z","caller":"traceutil/trace.go:171","msg":"trace[1185383752] transaction","detail":"{read_only:false; response_revision:5364; number_of_response:1; }","duration":"501.682269ms","start":"2026-04-08T23:04:35.799602Z","end":"2026-04-08T23:04:36.301284Z","steps":["trace[1185383752] 'process raft request'  (duration: 501.280899ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.301469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.799618Z","time spent":"501.801302ms","remote":"127.0.0.1:54028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:5094 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:880 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"warn","ts":"2026-04-08T23:04:36.30159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.460767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"}
{"level":"info","ts":"2026-04-08T23:04:36.301621Z","caller":"traceutil/trace.go:171","msg":"trace[602780187] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:5365; }","duration":"502.504227ms","start":"2026-04-08T23:04:35.799108Z","end":"2026-04-08T23:04:36.301612Z","steps":["trace[602780187] 'agreement among raft nodes before linearized reading'  (duration: 502.386305ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.301649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.799095Z","time spent":"502.548369ms","remote":"127.0.0.1:53950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1186,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "}
{"level":"warn","ts":"2026-04-08T23:04:36.301596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.799591Z","time spent":"501.927535ms","remote":"127.0.0.1:54028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:5100 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:828 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"warn","ts":"2026-04-08T23:04:36.313447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.812165ms","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-08T23:04:36.313467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.995437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:04:36.313457Z","caller":"traceutil/trace.go:171","msg":"trace[364294338] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"358.600186ms","start":"2026-04-08T23:04:35.954835Z","end":"2026-04-08T23:04:36.313436Z","steps":["trace[364294338] 'process raft request'  (duration: 358.290279ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:36.3135Z","caller":"traceutil/trace.go:171","msg":"trace[2018241459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5366; }","duration":"104.07946ms","start":"2026-04-08T23:04:36.209413Z","end":"2026-04-08T23:04:36.313493Z","steps":["trace[2018241459] 'agreement among raft nodes before linearized reading'  (duration: 104.021209ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:36.313493Z","caller":"traceutil/trace.go:171","msg":"trace[2060235192] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5366; }","duration":"347.901257ms","start":"2026-04-08T23:04:35.965579Z","end":"2026-04-08T23:04:36.31348Z","steps":["trace[2060235192] 'agreement among raft nodes before linearized reading'  (duration: 347.764024ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.31355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.965557Z","time spent":"347.985868ms","remote":"127.0.0.1:54142","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":"warn","ts":"2026-04-08T23:04:36.313609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.954804Z","time spent":"358.702038ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5349 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-08T23:04:36.313598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.516485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:04:36.313671Z","caller":"traceutil/trace.go:171","msg":"trace[1648563128] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5366; }","duration":"350.633067ms","start":"2026-04-08T23:04:35.963014Z","end":"2026-04-08T23:04:36.313647Z","steps":["trace[1648563128] 'agreement among raft nodes before linearized reading'  (duration: 350.399742ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.313785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.962993Z","time spent":"350.73127ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-08T23:04:36.313905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.453835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:04:36.314002Z","caller":"traceutil/trace.go:171","msg":"trace[292835422] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5366; }","duration":"317.65906ms","start":"2026-04-08T23:04:35.996327Z","end":"2026-04-08T23:04:36.313986Z","steps":["trace[292835422] 'agreement among raft nodes before linearized reading'  (duration: 317.141178ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.314139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:04:35.996317Z","time spent":"317.808923ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-04-08T23:04:36.4499Z","caller":"traceutil/trace.go:171","msg":"trace[1377167079] linearizableReadLoop","detail":"{readStateIndex:5565; appliedIndex:5561; }","duration":"130.394699ms","start":"2026-04-08T23:04:36.319481Z","end":"2026-04-08T23:04:36.449876Z","steps":["trace[1377167079] 'read index received'  (duration: 38.229166ms)","trace[1377167079] 'applied index is now lower than readState.Index'  (duration: 92.164313ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:04:36.450048Z","caller":"traceutil/trace.go:171","msg":"trace[169158407] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"132.287872ms","start":"2026-04-08T23:04:36.31772Z","end":"2026-04-08T23:04:36.450008Z","steps":["trace[169158407] 'process raft request'  (duration: 132.047506ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.450175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.684196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"}
{"level":"info","ts":"2026-04-08T23:04:36.450157Z","caller":"traceutil/trace.go:171","msg":"trace[619635957] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"132.023455ms","start":"2026-04-08T23:04:36.318092Z","end":"2026-04-08T23:04:36.450115Z","steps":["trace[619635957] 'process raft request'  (duration: 131.723758ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:36.450237Z","caller":"traceutil/trace.go:171","msg":"trace[167418776] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5370; }","duration":"130.759917ms","start":"2026-04-08T23:04:36.319463Z","end":"2026-04-08T23:04:36.450223Z","steps":["trace[167418776] 'agreement among raft nodes before linearized reading'  (duration: 130.563673ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:04:36.450094Z","caller":"traceutil/trace.go:171","msg":"trace[1778234776] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"132.364343ms","start":"2026-04-08T23:04:36.317666Z","end":"2026-04-08T23:04:36.45003Z","steps":["trace[1778234776] 'process raft request'  (duration: 120.308592ms)","trace[1778234776] 'compare'  (duration: 11.620371ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:04:36.698212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.570419ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640244251 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18a484281b13fd53\" mod_revision:5146 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18a484281b13fd53\" value_size:657 lease:599714801785467265 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-keystone.18a484281b13fd53\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:04:36.698492Z","caller":"traceutil/trace.go:171","msg":"trace[1471683334] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"208.906244ms","start":"2026-04-08T23:04:36.489563Z","end":"2026-04-08T23:04:36.698469Z","steps":["trace[1471683334] 'process raft request'  (duration: 95.984707ms)","trace[1471683334] 'compare'  (duration: 112.300734ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:04:36.723587Z","caller":"traceutil/trace.go:171","msg":"trace[2097080919] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"103.140539ms","start":"2026-04-08T23:04:36.6204Z","end":"2026-04-08T23:04:36.723541Z","steps":["trace[2097080919] 'process raft request'  (duration: 102.865663ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:04:36.723623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.560616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T23:04:36.723724Z","caller":"traceutil/trace.go:171","msg":"trace[587369837] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5373; }","duration":"111.69767ms","start":"2026-04-08T23:04:36.611998Z","end":"2026-04-08T23:04:36.723696Z","steps":["trace[587369837] 'agreement among raft nodes before linearized reading'  (duration: 111.528287ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:05:39.769491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2846}
{"level":"info","ts":"2026-04-08T23:05:39.848218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2846,"took":"76.361019ms","hash":2013312020,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":33095680,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-08T23:05:39.848293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2013312020,"revision":2846,"compact-revision":-1}
{"level":"info","ts":"2026-04-08T23:07:09.020573Z","caller":"traceutil/trace.go:171","msg":"trace[798098781] transaction","detail":"{read_only:false; response_revision:6458; number_of_response:1; }","duration":"102.726028ms","start":"2026-04-08T23:07:08.917803Z","end":"2026-04-08T23:07:09.020529Z","steps":["trace[798098781] 'compare'  (duration: 94.970865ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:07:54.179182Z","caller":"traceutil/trace.go:171","msg":"trace[288554892] transaction","detail":"{read_only:false; response_revision:6813; number_of_response:1; }","duration":"112.610251ms","start":"2026-04-08T23:07:54.066541Z","end":"2026-04-08T23:07:54.179151Z","steps":["trace[288554892] 'process raft request'  (duration: 67.367528ms)","trace[288554892] 'compare'  (duration: 45.079049ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:09:36.78823Z","caller":"traceutil/trace.go:171","msg":"trace[1821681260] transaction","detail":"{read_only:false; response_revision:7601; number_of_response:1; }","duration":"117.10113ms","start":"2026-04-08T23:09:36.671107Z","end":"2026-04-08T23:09:36.788208Z","steps":["trace[1821681260] 'process raft request'  (duration: 116.979717ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:11.044575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086838640251301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-08T23:10:11.54521Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086838640251301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-08T23:10:11.561401Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.017381054s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-08T23:10:11.562223Z","caller":"traceutil/trace.go:171","msg":"trace[239661922] transaction","detail":"{read_only:false; response_revision:7954; number_of_response:1; }","duration":"1.018228644s","start":"2026-04-08T23:10:10.54394Z","end":"2026-04-08T23:10:11.562169Z","steps":["trace[239661922] 'process raft request'  (duration: 1.017884367s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:11.562504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.543929Z","time spent":"1.018430028s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:7944 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-08T23:10:12.293785Z","caller":"traceutil/trace.go:171","msg":"trace[930479481] transaction","detail":"{read_only:false; response_revision:7957; number_of_response:1; }","duration":"532.198413ms","start":"2026-04-08T23:10:11.761539Z","end":"2026-04-08T23:10:12.293738Z","steps":["trace[930479481] 'process raft request'  (duration: 532.149112ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:12.293784Z","caller":"traceutil/trace.go:171","msg":"trace[1837387855] transaction","detail":"{read_only:false; response_revision:7956; number_of_response:1; }","duration":"1.648227363s","start":"2026-04-08T23:10:10.645496Z","end":"2026-04-08T23:10:12.293724Z","steps":["trace[1837387855] 'process raft request'  (duration: 1.64808609s)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:12.293814Z","caller":"traceutil/trace.go:171","msg":"trace[1271969265] transaction","detail":"{read_only:false; response_revision:7955; number_of_response:1; }","duration":"1.748281512s","start":"2026-04-08T23:10:10.545473Z","end":"2026-04-08T23:10:12.293754Z","steps":["trace[1271969265] 'process raft request'  (duration: 1.707361847s)","trace[1271969265] 'compare'  (duration: 40.403793ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:12.293785Z","caller":"traceutil/trace.go:171","msg":"trace[394672206] linearizableReadLoop","detail":"{readStateIndex:8230; appliedIndex:8227; }","duration":"1.74957261s","start":"2026-04-08T23:10:10.544165Z","end":"2026-04-08T23:10:12.293737Z","steps":["trace[394672206] 'read index received'  (duration: 1.017584519s)","trace[394672206] 'applied index is now lower than readState.Index'  (duration: 731.980061ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:12.293941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.749773044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-04-08T23:10:12.29398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:11.761509Z","time spent":"532.360767ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7952 > 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-08T23:10:12.293999Z","caller":"traceutil/trace.go:171","msg":"trace[1841610061] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7957; }","duration":"1.749889767s","start":"2026-04-08T23:10:10.544093Z","end":"2026-04-08T23:10:12.293982Z","steps":["trace[1841610061] 'agreement among raft nodes before linearized reading'  (duration: 1.749744183s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:12.294003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.545451Z","time spent":"1.748456865s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:7945 > 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-08T23:10:12.294028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.54406Z","time spent":"1.749963078s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-08T23:10:12.29403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.645483Z","time spent":"1.648417798s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:7948 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-08T23:10:12.294241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.673761615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T23:10:12.294314Z","caller":"traceutil/trace.go:171","msg":"trace[2005733326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7957; }","duration":"1.673869096s","start":"2026-04-08T23:10:10.620426Z","end":"2026-04-08T23:10:12.294295Z","steps":["trace[2005733326] 'agreement among raft nodes before linearized reading'  (duration: 1.673633791s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:12.294367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.620412Z","time spent":"1.673941719s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-08T23:10:12.294394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.516273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-04-08T23:10:12.294394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084813482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:12.294413Z","caller":"traceutil/trace.go:171","msg":"trace[1969764769] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7957; }","duration":"182.580844ms","start":"2026-04-08T23:10:12.111827Z","end":"2026-04-08T23:10:12.294408Z","steps":["trace[1969764769] 'agreement among raft nodes before linearized reading'  (duration: 182.524083ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:12.294437Z","caller":"traceutil/trace.go:171","msg":"trace[1811735229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7957; }","duration":"1.084897594s","start":"2026-04-08T23:10:11.209527Z","end":"2026-04-08T23:10:12.294425Z","steps":["trace[1811735229] 'agreement among raft nodes before linearized reading'  (duration: 1.084806052s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:12.29448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:11.209497Z","time spent":"1.084978306s","remote":"127.0.0.1:53850","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-08T23:10:12.294577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.635050468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-04-08T23:10:12.294608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247400329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tlwqz\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-04-08T23:10:12.294615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.635180561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:10:12.294666Z","caller":"traceutil/trace.go:171","msg":"trace[1311366939] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tlwqz; range_end:; response_count:1; response_revision:7957; }","duration":"1.24748807s","start":"2026-04-08T23:10:11.047164Z","end":"2026-04-08T23:10:12.294652Z","steps":["trace[1311366939] 'agreement among raft nodes before linearized reading'  (duration: 1.247292446s)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:12.294679Z","caller":"traceutil/trace.go:171","msg":"trace[1106324044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7957; }","duration":"1.635177231s","start":"2026-04-08T23:10:10.659473Z","end":"2026-04-08T23:10:12.29465Z","steps":["trace[1106324044] 'agreement among raft nodes before linearized reading'  (duration: 1.634890985s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:12.294699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:11.047143Z","time spent":"1.247549362s","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-tlwqz\" "}
{"level":"info","ts":"2026-04-08T23:10:12.294698Z","caller":"traceutil/trace.go:171","msg":"trace[322477459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7957; }","duration":"1.635335505s","start":"2026-04-08T23:10:10.65934Z","end":"2026-04-08T23:10:12.294675Z","steps":["trace[322477459] 'agreement among raft nodes before linearized reading'  (duration: 1.635051659s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:12.294745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.659307Z","time spent":"1.635428737s","remote":"127.0.0.1:54142","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-08T23:10:12.294741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:10.659461Z","time spent":"1.635267583s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-08T23:10:18.571168Z","caller":"traceutil/trace.go:171","msg":"trace[1136226921] transaction","detail":"{read_only:false; response_revision:7991; number_of_response:1; }","duration":"173.402912ms","start":"2026-04-08T23:10:18.397744Z","end":"2026-04-08T23:10:18.571147Z","steps":["trace[1136226921] 'process raft request'  (duration: 173.31615ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:18.571178Z","caller":"traceutil/trace.go:171","msg":"trace[1740773655] transaction","detail":"{read_only:false; response_revision:7990; number_of_response:1; }","duration":"173.508364ms","start":"2026-04-08T23:10:18.397631Z","end":"2026-04-08T23:10:18.571139Z","steps":["trace[1740773655] 'process raft request'  (duration: 102.523169ms)","trace[1740773655] 'compare'  (duration: 70.78195ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:18.571395Z","caller":"traceutil/trace.go:171","msg":"trace[399802924] transaction","detail":"{read_only:false; response_revision:7992; number_of_response:1; }","duration":"173.554435ms","start":"2026-04-08T23:10:18.397825Z","end":"2026-04-08T23:10:18.571379Z","steps":["trace[399802924] 'process raft request'  (duration: 173.284709ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:18.571749Z","caller":"traceutil/trace.go:171","msg":"trace[1246074727] transaction","detail":"{read_only:false; response_revision:7993; number_of_response:1; }","duration":"173.833542ms","start":"2026-04-08T23:10:18.397885Z","end":"2026-04-08T23:10:18.571719Z","steps":["trace[1246074727] 'process raft request'  (duration: 173.435523ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:18.571879Z","caller":"traceutil/trace.go:171","msg":"trace[958255805] linearizableReadLoop","detail":"{readStateIndex:8269; appliedIndex:8264; }","duration":"173.616697ms","start":"2026-04-08T23:10:18.398234Z","end":"2026-04-08T23:10:18.571851Z","steps":["trace[958255805] 'read index received'  (duration: 20.074488ms)","trace[958255805] 'applied index is now lower than readState.Index'  (duration: 153.541069ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:18.571931Z","caller":"traceutil/trace.go:171","msg":"trace[587237231] transaction","detail":"{read_only:false; response_revision:7994; number_of_response:1; }","duration":"172.979523ms","start":"2026-04-08T23:10:18.398922Z","end":"2026-04-08T23:10:18.571901Z","steps":["trace[587237231] 'process raft request'  (duration: 172.736367ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:18.572253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.007365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:207034"}
{"level":"info","ts":"2026-04-08T23:10:18.572314Z","caller":"traceutil/trace.go:171","msg":"trace[787093549] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:7994; }","duration":"174.100668ms","start":"2026-04-08T23:10:18.398201Z","end":"2026-04-08T23:10:18.572302Z","steps":["trace[787093549] 'agreement among raft nodes before linearized reading'  (duration: 173.74767ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:22.777016Z","caller":"traceutil/trace.go:171","msg":"trace[328478793] transaction","detail":"{read_only:false; response_revision:8010; number_of_response:1; }","duration":"188.521699ms","start":"2026-04-08T23:10:22.588469Z","end":"2026-04-08T23:10:22.77699Z","steps":["trace[328478793] 'process raft request'  (duration: 100.502064ms)","trace[328478793] 'compare'  (duration: 87.653697ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:22.777036Z","caller":"traceutil/trace.go:171","msg":"trace[1742679883] transaction","detail":"{read_only:false; response_revision:8011; number_of_response:1; }","duration":"187.611178ms","start":"2026-04-08T23:10:22.589391Z","end":"2026-04-08T23:10:22.777002Z","steps":["trace[1742679883] 'process raft request'  (duration: 187.473155ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:22.777005Z","caller":"traceutil/trace.go:171","msg":"trace[868914564] linearizableReadLoop","detail":"{readStateIndex:8287; appliedIndex:8284; }","duration":"187.427845ms","start":"2026-04-08T23:10:22.58955Z","end":"2026-04-08T23:10:22.776978Z","steps":["trace[868914564] 'read index received'  (duration: 69.262417ms)","trace[868914564] 'applied index is now lower than readState.Index'  (duration: 118.164318ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:22.777215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.64158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:10:22.777259Z","caller":"traceutil/trace.go:171","msg":"trace[1239634529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8011; }","duration":"187.703011ms","start":"2026-04-08T23:10:22.589544Z","end":"2026-04-08T23:10:22.777247Z","steps":["trace[1239634529] 'agreement among raft nodes before linearized reading'  (duration: 187.515727ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:22.823322Z","caller":"traceutil/trace.go:171","msg":"trace[1656521205] transaction","detail":"{read_only:false; response_revision:8012; number_of_response:1; }","duration":"131.507787ms","start":"2026-04-08T23:10:22.691791Z","end":"2026-04-08T23:10:22.823298Z","steps":["trace[1656521205] 'process raft request'  (duration: 131.314483ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:22.823457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.566355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:10:22.823521Z","caller":"traceutil/trace.go:171","msg":"trace[29084583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8012; }","duration":"233.652466ms","start":"2026-04-08T23:10:22.589852Z","end":"2026-04-08T23:10:22.823504Z","steps":["trace[29084583] 'agreement among raft nodes before linearized reading'  (duration: 233.490083ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:22.823522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.484081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tlwqz\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T23:10:22.823608Z","caller":"traceutil/trace.go:171","msg":"trace[88518707] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tlwqz; range_end:; response_count:1; response_revision:8012; }","duration":"232.630844ms","start":"2026-04-08T23:10:22.590957Z","end":"2026-04-08T23:10:22.823588Z","steps":["trace[88518707] 'agreement among raft nodes before linearized reading'  (duration: 232.355638ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:24.024912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.92773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-04-08T23:10:24.024997Z","caller":"traceutil/trace.go:171","msg":"trace[1258214756] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8015; }","duration":"851.066653ms","start":"2026-04-08T23:10:23.173915Z","end":"2026-04-08T23:10:24.024981Z","steps":["trace[1258214756] 'range keys from in-memory index tree'  (duration: 850.733045ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:24.025027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:23.17388Z","time spent":"851.141195ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-04-08T23:10:24.025026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.146936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1984"}
{"level":"info","ts":"2026-04-08T23:10:24.025097Z","caller":"traceutil/trace.go:171","msg":"trace[1841865389] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8015; }","duration":"826.245159ms","start":"2026-04-08T23:10:23.198833Z","end":"2026-04-08T23:10:24.025078Z","steps":["trace[1841865389] 'range keys from in-memory index tree'  (duration: 825.960952ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:24.025142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:23.198822Z","time spent":"826.30584ms","remote":"127.0.0.1:54050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2008,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "}
{"level":"warn","ts":"2026-04-08T23:10:24.025343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.082003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:24.025377Z","caller":"traceutil/trace.go:171","msg":"trace[860393936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8015; }","duration":"812.144744ms","start":"2026-04-08T23:10:23.213224Z","end":"2026-04-08T23:10:24.025368Z","steps":["trace[860393936] 'range keys from in-memory index tree'  (duration: 812.013241ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:24.025403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:23.213204Z","time spent":"812.192695ms","remote":"127.0.0.1:53850","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-08T23:10:24.025245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.886293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-08T23:10:24.02581Z","caller":"traceutil/trace.go:171","msg":"trace[640111854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8015; }","duration":"406.496996ms","start":"2026-04-08T23:10:23.619287Z","end":"2026-04-08T23:10:24.025784Z","steps":["trace[640111854] 'range keys from in-memory index tree'  (duration: 405.681709ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:24.025918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:23.619265Z","time spent":"406.633019ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-08T23:10:24.234091Z","caller":"traceutil/trace.go:171","msg":"trace[796557215] transaction","detail":"{read_only:false; response_revision:8017; number_of_response:1; }","duration":"204.128067ms","start":"2026-04-08T23:10:24.029936Z","end":"2026-04-08T23:10:24.234064Z","steps":["trace[796557215] 'process raft request'  (duration: 204.068395ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:24.23414Z","caller":"traceutil/trace.go:171","msg":"trace[1390961525] transaction","detail":"{read_only:false; response_revision:8016; number_of_response:1; }","duration":"204.187079ms","start":"2026-04-08T23:10:24.029928Z","end":"2026-04-08T23:10:24.234115Z","steps":["trace[1390961525] 'process raft request'  (duration: 203.897472ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:24.24875Z","caller":"traceutil/trace.go:171","msg":"trace[744227957] linearizableReadLoop","detail":"{readStateIndex:8295; appliedIndex:8292; }","duration":"159.193045ms","start":"2026-04-08T23:10:24.089526Z","end":"2026-04-08T23:10:24.248719Z","steps":["trace[744227957] 'read index received'  (duration: 144.297491ms)","trace[744227957] 'applied index is now lower than readState.Index'  (duration: 14.893894ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:24.249049Z","caller":"traceutil/trace.go:171","msg":"trace[1044838370] transaction","detail":"{read_only:false; response_revision:8018; number_of_response:1; }","duration":"215.932971ms","start":"2026-04-08T23:10:24.033081Z","end":"2026-04-08T23:10:24.249014Z","steps":["trace[1044838370] 'process raft request'  (duration: 215.456371ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:24.249084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.534722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:24.249301Z","caller":"traceutil/trace.go:171","msg":"trace[1669894961] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8018; }","duration":"159.768387ms","start":"2026-04-08T23:10:24.089509Z","end":"2026-04-08T23:10:24.249278Z","steps":["trace[1669894961] 'agreement among raft nodes before linearized reading'  (duration: 159.325557ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:25.35193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.59827ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640251560 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8014 > 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:16"}
{"level":"info","ts":"2026-04-08T23:10:25.352178Z","caller":"traceutil/trace.go:171","msg":"trace[1537140488] linearizableReadLoop","detail":"{readStateIndex:8306; appliedIndex:8304; }","duration":"490.733298ms","start":"2026-04-08T23:10:24.861421Z","end":"2026-04-08T23:10:25.352154Z","steps":["trace[1537140488] 'read index received'  (duration: 177.821151ms)","trace[1537140488] 'applied index is now lower than readState.Index'  (duration: 312.910787ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:25.352167Z","caller":"traceutil/trace.go:171","msg":"trace[720977842] transaction","detail":"{read_only:false; response_revision:8027; number_of_response:1; }","duration":"491.384753ms","start":"2026-04-08T23:10:24.860748Z","end":"2026-04-08T23:10:25.352133Z","steps":["trace[720977842] 'process raft request'  (duration: 178.480925ms)","trace[720977842] 'compare'  (duration: 312.486457ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:25.352285Z","caller":"traceutil/trace.go:171","msg":"trace[950304364] transaction","detail":"{read_only:false; response_revision:8028; number_of_response:1; }","duration":"490.886072ms","start":"2026-04-08T23:10:24.861384Z","end":"2026-04-08T23:10:25.35227Z","steps":["trace[950304364] 'process raft request'  (duration: 490.682937ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:25.352319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:24.860733Z","time spent":"491.511495ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8014 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-08T23:10:25.35238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:24.861366Z","time spent":"490.966163ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8013 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-08T23:10:25.352809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.345671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:207034"}
{"level":"info","ts":"2026-04-08T23:10:25.352913Z","caller":"traceutil/trace.go:171","msg":"trace[409347571] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:8028; }","duration":"491.497305ms","start":"2026-04-08T23:10:24.861396Z","end":"2026-04-08T23:10:25.352893Z","steps":["trace[409347571] 'agreement among raft nodes before linearized reading'  (duration: 490.881522ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:25.353013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:24.861383Z","time spent":"491.603587ms","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":24,"response size":207058,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-04-08T23:10:25.853212Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086838640251563,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-08T23:10:26.33511Z","caller":"traceutil/trace.go:171","msg":"trace[409970395] linearizableReadLoop","detail":"{readStateIndex:8307; appliedIndex:8306; }","duration":"982.856365ms","start":"2026-04-08T23:10:25.352229Z","end":"2026-04-08T23:10:26.335085Z","steps":["trace[409970395] 'read index received'  (duration: 917.121247ms)","trace[409970395] 'applied index is now lower than readState.Index'  (duration: 65.733878ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:26.335201Z","caller":"traceutil/trace.go:171","msg":"trace[1158649429] transaction","detail":"{read_only:false; response_revision:8029; number_of_response:1; }","duration":"1.030653812s","start":"2026-04-08T23:10:25.304505Z","end":"2026-04-08T23:10:26.335159Z","steps":["trace[1158649429] 'process raft request'  (duration: 964.892954ms)","trace[1158649429] 'compare'  (duration: 65.559094ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:26.335271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126499113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:26.335316Z","caller":"traceutil/trace.go:171","msg":"trace[1138545275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8029; }","duration":"1.126608966s","start":"2026-04-08T23:10:25.208694Z","end":"2026-04-08T23:10:26.335303Z","steps":["trace[1138545275] 'agreement among raft nodes before linearized reading'  (duration: 1.126524974s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:26.335356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:25.208668Z","time spent":"1.126680968s","remote":"127.0.0.1:53850","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-08T23:10:26.335418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:25.304483Z","time spent":"1.030811966s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:7973 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-08T23:10:26.335483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.755359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:26.33554Z","caller":"traceutil/trace.go:171","msg":"trace[1846135873] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:8029; }","duration":"443.847341ms","start":"2026-04-08T23:10:25.891675Z","end":"2026-04-08T23:10:26.335522Z","steps":["trace[1846135873] 'agreement among raft nodes before linearized reading'  (duration: 443.77866ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:26.335586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:25.891649Z","time spent":"443.927963ms","remote":"127.0.0.1:43450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T23:10:26.335407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.459279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7bcc8ddfd7-nlt7x.18a484786399facd\" ","response":"range_response_count:1 size:1135"}
{"level":"info","ts":"2026-04-08T23:10:26.335731Z","caller":"traceutil/trace.go:171","msg":"trace[344358211] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7bcc8ddfd7-nlt7x.18a484786399facd; range_end:; response_count:1; response_revision:8029; }","duration":"639.822487ms","start":"2026-04-08T23:10:25.695881Z","end":"2026-04-08T23:10:26.335703Z","steps":["trace[344358211] 'agreement among raft nodes before linearized reading'  (duration: 639.392477ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:26.335785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:25.695857Z","time spent":"639.916139ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1159,"request content":"key:\"/registry/events/openstack/barbican-api-7bcc8ddfd7-nlt7x.18a484786399facd\" "}
{"level":"warn","ts":"2026-04-08T23:10:26.336433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.206073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-08T23:10:26.336811Z","caller":"traceutil/trace.go:171","msg":"trace[386774205] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8029; }","duration":"330.598662ms","start":"2026-04-08T23:10:26.006193Z","end":"2026-04-08T23:10:26.336791Z","steps":["trace[386774205] 'agreement among raft nodes before linearized reading'  (duration: 329.178451ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:26.337053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:26.006129Z","time spent":"330.889518ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":807,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-04-08T23:10:26.519014Z","caller":"traceutil/trace.go:171","msg":"trace[1816801122] transaction","detail":"{read_only:false; response_revision:8031; number_of_response:1; }","duration":"178.586978ms","start":"2026-04-08T23:10:26.340382Z","end":"2026-04-08T23:10:26.518968Z","steps":["trace[1816801122] 'process raft request'  (duration: 113.170807ms)","trace[1816801122] 'compare'  (duration: 65.259148ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:26.519132Z","caller":"traceutil/trace.go:171","msg":"trace[1985427379] linearizableReadLoop","detail":"{readStateIndex:8309; appliedIndex:8307; }","duration":"174.334352ms","start":"2026-04-08T23:10:26.344743Z","end":"2026-04-08T23:10:26.519077Z","steps":["trace[1985427379] 'read index received'  (duration: 33.231862ms)","trace[1985427379] 'applied index is now lower than readState.Index'  (duration: 141.08521ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:26.519267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.495696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:26.519366Z","caller":"traceutil/trace.go:171","msg":"trace[344743577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8032; }","duration":"174.637759ms","start":"2026-04-08T23:10:26.344704Z","end":"2026-04-08T23:10:26.519342Z","steps":["trace[344743577] 'agreement among raft nodes before linearized reading'  (duration: 174.463165ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:26.818576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.369598ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640251573 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8022 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:10:26.818681Z","caller":"traceutil/trace.go:171","msg":"trace[1849627639] linearizableReadLoop","detail":"{readStateIndex:8312; appliedIndex:8311; }","duration":"134.81983ms","start":"2026-04-08T23:10:26.683847Z","end":"2026-04-08T23:10:26.818666Z","steps":["trace[1849627639] 'read index received'  (duration: 61.411µs)","trace[1849627639] 'applied index is now lower than readState.Index'  (duration: 134.757449ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:26.818799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.963974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T23:10:26.818825Z","caller":"traceutil/trace.go:171","msg":"trace[831002908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8034; }","duration":"135.031055ms","start":"2026-04-08T23:10:26.683784Z","end":"2026-04-08T23:10:26.818816Z","steps":["trace[831002908] 'agreement among raft nodes before linearized reading'  (duration: 134.920103ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:26.818794Z","caller":"traceutil/trace.go:171","msg":"trace[56361289] transaction","detail":"{read_only:false; response_revision:8034; number_of_response:1; }","duration":"239.454206ms","start":"2026-04-08T23:10:26.579283Z","end":"2026-04-08T23:10:26.818737Z","steps":["trace[56361289] 'process raft request'  (duration: 92.817133ms)","trace[56361289] 'compare'  (duration: 146.255105ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:27.298423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.464041ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640251577 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8025 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:10:27.298499Z","caller":"traceutil/trace.go:171","msg":"trace[1045882657] linearizableReadLoop","detail":"{readStateIndex:8314; appliedIndex:8313; }","duration":"435.297319ms","start":"2026-04-08T23:10:26.863189Z","end":"2026-04-08T23:10:27.298486Z","steps":["trace[1045882657] 'read index received'  (duration: 64.605983ms)","trace[1045882657] 'applied index is now lower than readState.Index'  (duration: 370.690626ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:27.298612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.424322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:10:27.298625Z","caller":"traceutil/trace.go:171","msg":"trace[1168362656] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8036; }","duration":"435.470123ms","start":"2026-04-08T23:10:26.86315Z","end":"2026-04-08T23:10:27.29862Z","steps":["trace[1168362656] 'agreement among raft nodes before linearized reading'  (duration: 435.365851ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:27.298643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:26.863135Z","time spent":"435.504263ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-04-08T23:10:27.298807Z","caller":"traceutil/trace.go:171","msg":"trace[465365957] transaction","detail":"{read_only:false; response_revision:8036; number_of_response:1; }","duration":"443.977963ms","start":"2026-04-08T23:10:26.854822Z","end":"2026-04-08T23:10:27.2988Z","steps":["trace[465365957] 'process raft request'  (duration: 73.070242ms)","trace[465365957] 'compare'  (duration: 369.685794ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:27.298837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:26.854794Z","time spent":"444.026394ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8025 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-08T23:10:27.815193Z","caller":"traceutil/trace.go:171","msg":"trace[2062836688] transaction","detail":"{read_only:false; response_revision:8037; number_of_response:1; }","duration":"510.423526ms","start":"2026-04-08T23:10:27.304735Z","end":"2026-04-08T23:10:27.815158Z","steps":["trace[2062836688] 'process raft request'  (duration: 504.376851ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:27.81533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.30058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:27.815387Z","caller":"traceutil/trace.go:171","msg":"trace[1797364119] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:8037; }","duration":"487.419833ms","start":"2026-04-08T23:10:27.327954Z","end":"2026-04-08T23:10:27.815374Z","steps":["trace[1797364119] 'agreement among raft nodes before linearized reading'  (duration: 487.29551ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:27.815429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:27.327934Z","time spent":"487.484855ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "}
{"level":"info","ts":"2026-04-08T23:10:27.815183Z","caller":"traceutil/trace.go:171","msg":"trace[1349462610] linearizableReadLoop","detail":"{readStateIndex:8315; appliedIndex:8314; }","duration":"487.156837ms","start":"2026-04-08T23:10:27.327997Z","end":"2026-04-08T23:10:27.815154Z","steps":["trace[1349462610] 'read index received'  (duration: 481.129573ms)","trace[1349462610] 'applied index is now lower than readState.Index'  (duration: 6.025884ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:27.815678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:27.304711Z","time spent":"510.628911ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8026 > 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-08T23:10:27.836248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.425402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T23:10:27.836279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.260023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:10:27.836331Z","caller":"traceutil/trace.go:171","msg":"trace[314625295] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8038; }","duration":"422.556305ms","start":"2026-04-08T23:10:27.413754Z","end":"2026-04-08T23:10:27.83631Z","steps":["trace[314625295] 'agreement among raft nodes before linearized reading'  (duration: 422.414622ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:27.836361Z","caller":"traceutil/trace.go:171","msg":"trace[1993097327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8038; }","duration":"480.377726ms","start":"2026-04-08T23:10:27.355962Z","end":"2026-04-08T23:10:27.83634Z","steps":["trace[1993097327] 'agreement among raft nodes before linearized reading'  (duration: 480.155831ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:27.83638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:27.413734Z","time spent":"422.634997ms","remote":"127.0.0.1:47542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T23:10:27.836408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:27.35595Z","time spent":"480.449617ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-08T23:10:27.836584Z","caller":"traceutil/trace.go:171","msg":"trace[898715441] transaction","detail":"{read_only:false; response_revision:8038; number_of_response:1; }","duration":"168.713357ms","start":"2026-04-08T23:10:27.667848Z","end":"2026-04-08T23:10:27.836561Z","steps":["trace[898715441] 'process raft request'  (duration: 168.115114ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:27.83666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.380745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-08T23:10:27.836671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.795203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tlwqz\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T23:10:27.836738Z","caller":"traceutil/trace.go:171","msg":"trace[890697700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8038; }","duration":"480.476208ms","start":"2026-04-08T23:10:27.356245Z","end":"2026-04-08T23:10:27.836721Z","steps":["trace[890697700] 'agreement among raft nodes before linearized reading'  (duration: 480.257123ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:27.836754Z","caller":"traceutil/trace.go:171","msg":"trace[1093450803] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tlwqz; range_end:; response_count:1; response_revision:8038; }","duration":"475.900316ms","start":"2026-04-08T23:10:27.360835Z","end":"2026-04-08T23:10:27.836735Z","steps":["trace[1093450803] 'agreement among raft nodes before linearized reading'  (duration: 475.62828ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:27.836784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:27.356239Z","time spent":"480.536639ms","remote":"127.0.0.1:54142","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-08T23:10:27.8368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:27.36083Z","time spent":"475.961437ms","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-tlwqz\" "}
{"level":"info","ts":"2026-04-08T23:10:28.876087Z","caller":"traceutil/trace.go:171","msg":"trace[180475627] linearizableReadLoop","detail":"{readStateIndex:8320; appliedIndex:8319; }","duration":"352.215554ms","start":"2026-04-08T23:10:28.523851Z","end":"2026-04-08T23:10:28.876067Z","steps":["trace[180475627] 'read index received'  (duration: 352.093362ms)","trace[180475627] 'applied index is now lower than readState.Index'  (duration: 121.162µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:28.876126Z","caller":"traceutil/trace.go:171","msg":"trace[1988807193] transaction","detail":"{read_only:false; response_revision:8041; number_of_response:1; }","duration":"352.745335ms","start":"2026-04-08T23:10:28.52336Z","end":"2026-04-08T23:10:28.876105Z","steps":["trace[1988807193] 'process raft request'  (duration: 352.561891ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:28.876248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:28.523339Z","time spent":"352.837279ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8032 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-08T23:10:28.87639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.516802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-08T23:10:28.876481Z","caller":"traceutil/trace.go:171","msg":"trace[2119529027] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8041; }","duration":"352.643634ms","start":"2026-04-08T23:10:28.523816Z","end":"2026-04-08T23:10:28.87646Z","steps":["trace[2119529027] 'agreement among raft nodes before linearized reading'  (duration: 352.332167ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:28.876539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:28.5238Z","time spent":"352.726626ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-08T23:10:28.881802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.063489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T23:10:28.881813Z","caller":"traceutil/trace.go:171","msg":"trace[1050680497] transaction","detail":"{read_only:false; response_revision:8042; number_of_response:1; }","duration":"305.052742ms","start":"2026-04-08T23:10:28.576742Z","end":"2026-04-08T23:10:28.881794Z","steps":["trace[1050680497] 'process raft request'  (duration: 304.850477ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:28.881842Z","caller":"traceutil/trace.go:171","msg":"trace[720735569] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8042; }","duration":"355.14255ms","start":"2026-04-08T23:10:28.526689Z","end":"2026-04-08T23:10:28.881831Z","steps":["trace[720735569] 'agreement among raft nodes before linearized reading'  (duration: 355.063608ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:28.881867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:28.526673Z","time spent":"355.187621ms","remote":"127.0.0.1:37126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T23:10:28.882076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:28.576719Z","time spent":"305.135353ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8033 > 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-08T23:10:39.788606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5947}
{"level":"info","ts":"2026-04-08T23:10:39.924562Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5947,"took":"133.994701ms","hash":3604856640,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":26050560,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-08T23:10:39.924633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3604856640,"revision":5947,"compact-revision":2846}
{"level":"info","ts":"2026-04-08T23:10:47.547874Z","caller":"traceutil/trace.go:171","msg":"trace[1546195675] transaction","detail":"{read_only:false; response_revision:8146; number_of_response:1; }","duration":"124.983592ms","start":"2026-04-08T23:10:47.422824Z","end":"2026-04-08T23:10:47.547807Z","steps":["trace[1546195675] 'process raft request'  (duration: 124.813948ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:51.197052Z","caller":"traceutil/trace.go:171","msg":"trace[730910366] transaction","detail":"{read_only:false; response_revision:8164; number_of_response:1; }","duration":"113.156577ms","start":"2026-04-08T23:10:51.083859Z","end":"2026-04-08T23:10:51.197015Z","steps":["trace[730910366] 'process raft request'  (duration: 52.989734ms)","trace[730910366] 'compare'  (duration: 59.855086ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:53.453439Z","caller":"traceutil/trace.go:171","msg":"trace[2049432744] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"249.719586ms","start":"2026-04-08T23:10:53.203695Z","end":"2026-04-08T23:10:53.453415Z","steps":["trace[2049432744] 'process raft request'  (duration: 249.583503ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:53.453453Z","caller":"traceutil/trace.go:171","msg":"trace[1433344239] linearizableReadLoop","detail":"{readStateIndex:8460; appliedIndex:8460; }","duration":"244.153641ms","start":"2026-04-08T23:10:53.209259Z","end":"2026-04-08T23:10:53.453413Z","steps":["trace[1433344239] 'read index received'  (duration: 244.137171ms)","trace[1433344239] 'applied index is now lower than readState.Index'  (duration: 13.89µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:53.453609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.336885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:53.453669Z","caller":"traceutil/trace.go:171","msg":"trace[1122477845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8175; }","duration":"244.434118ms","start":"2026-04-08T23:10:53.209221Z","end":"2026-04-08T23:10:53.453656Z","steps":["trace[1122477845] 'agreement among raft nodes before linearized reading'  (duration: 244.333426ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:53.69583Z","caller":"traceutil/trace.go:171","msg":"trace[1914651080] linearizableReadLoop","detail":"{readStateIndex:8461; appliedIndex:8460; }","duration":"242.278339ms","start":"2026-04-08T23:10:53.453528Z","end":"2026-04-08T23:10:53.695807Z","steps":["trace[1914651080] 'read index received'  (duration: 240.771226ms)","trace[1914651080] 'applied index is now lower than readState.Index'  (duration: 1.506083ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:10:53.696115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.392297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-08T23:10:53.696188Z","caller":"traceutil/trace.go:171","msg":"trace[1546760606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8176; }","duration":"476.54134ms","start":"2026-04-08T23:10:53.219631Z","end":"2026-04-08T23:10:53.696173Z","steps":["trace[1546760606] 'agreement among raft nodes before linearized reading'  (duration: 476.359836ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:53.696188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.695623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-04-08T23:10:53.696215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:53.219612Z","time spent":"476.595851ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-08T23:10:53.696224Z","caller":"traceutil/trace.go:171","msg":"trace[299621055] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8176; }","duration":"476.754005ms","start":"2026-04-08T23:10:53.21946Z","end":"2026-04-08T23:10:53.696214Z","steps":["trace[299621055] 'agreement among raft nodes before linearized reading'  (duration: 476.645673ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:53.696256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:53.219448Z","time spent":"476.801116ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-08T23:10:53.696298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.474611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:53.69632Z","caller":"traceutil/trace.go:171","msg":"trace[663485197] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"356.729794ms","start":"2026-04-08T23:10:53.339543Z","end":"2026-04-08T23:10:53.696273Z","steps":["trace[663485197] 'process raft request'  (duration: 354.731901ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:53.696382Z","caller":"traceutil/trace.go:171","msg":"trace[1422767536] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:8176; }","duration":"417.568174ms","start":"2026-04-08T23:10:53.278789Z","end":"2026-04-08T23:10:53.696357Z","steps":["trace[1422767536] 'agreement among raft nodes before linearized reading'  (duration: 417.42588ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:53.696441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:53.278776Z","time spent":"417.651576ms","remote":"127.0.0.1:54310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T23:10:53.696485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.114711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-04-08T23:10:53.696504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:53.339521Z","time spent":"356.89406ms","remote":"127.0.0.1:54032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19303,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:8012 > success:<request_put:<key:\"/registry/minions/instance\" value_size:19267 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-04-08T23:10:53.696591Z","caller":"traceutil/trace.go:171","msg":"trace[75093188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8176; }","duration":"476.244193ms","start":"2026-04-08T23:10:53.220339Z","end":"2026-04-08T23:10:53.696583Z","steps":["trace[75093188] 'agreement among raft nodes before linearized reading'  (duration: 476.046329ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:53.696629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:53.220325Z","time spent":"476.296755ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-08T23:10:53.696711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.235536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:53.696881Z","caller":"traceutil/trace.go:171","msg":"trace[1577017572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8176; }","duration":"241.467173ms","start":"2026-04-08T23:10:53.455358Z","end":"2026-04-08T23:10:53.696825Z","steps":["trace[1577017572] 'agreement among raft nodes before linearized reading'  (duration: 241.171516ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:53.970773Z","caller":"traceutil/trace.go:171","msg":"trace[49672384] transaction","detail":"{read_only:false; response_revision:8181; number_of_response:1; }","duration":"116.798137ms","start":"2026-04-08T23:10:53.853937Z","end":"2026-04-08T23:10:53.970735Z","steps":["trace[49672384] 'process raft request'  (duration: 116.661354ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.079768Z","caller":"traceutil/trace.go:171","msg":"trace[1045312098] transaction","detail":"{read_only:false; response_revision:8187; number_of_response:1; }","duration":"101.530917ms","start":"2026-04-08T23:10:53.978208Z","end":"2026-04-08T23:10:54.079739Z","steps":["trace[1045312098] 'process raft request'  (duration: 101.495166ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.079836Z","caller":"traceutil/trace.go:171","msg":"trace[184619871] transaction","detail":"{read_only:false; response_revision:8183; number_of_response:1; }","duration":"102.075609ms","start":"2026-04-08T23:10:53.977752Z","end":"2026-04-08T23:10:54.079828Z","steps":["trace[184619871] 'process raft request'  (duration: 101.713331ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.079893Z","caller":"traceutil/trace.go:171","msg":"trace[1269609634] transaction","detail":"{read_only:false; response_revision:8185; number_of_response:1; }","duration":"102.036758ms","start":"2026-04-08T23:10:53.977829Z","end":"2026-04-08T23:10:54.079866Z","steps":["trace[1269609634] 'process raft request'  (duration: 101.820823ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.079769Z","caller":"traceutil/trace.go:171","msg":"trace[373011353] transaction","detail":"{read_only:false; response_revision:8184; number_of_response:1; }","duration":"101.885965ms","start":"2026-04-08T23:10:53.977855Z","end":"2026-04-08T23:10:54.079741Z","steps":["trace[373011353] 'process raft request'  (duration: 101.761382ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.079943Z","caller":"traceutil/trace.go:171","msg":"trace[431380164] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"101.995677ms","start":"2026-04-08T23:10:53.977913Z","end":"2026-04-08T23:10:54.079909Z","steps":["trace[431380164] 'process raft request'  (duration: 101.762402ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.269637Z","caller":"traceutil/trace.go:171","msg":"trace[1249923052] transaction","detail":"{read_only:false; response_revision:8190; number_of_response:1; }","duration":"160.298709ms","start":"2026-04-08T23:10:54.109318Z","end":"2026-04-08T23:10:54.269616Z","steps":["trace[1249923052] 'process raft request'  (duration: 154.631182ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.26968Z","caller":"traceutil/trace.go:171","msg":"trace[313450479] linearizableReadLoop","detail":"{readStateIndex:8478; appliedIndex:8475; }","duration":"121.108774ms","start":"2026-04-08T23:10:54.14855Z","end":"2026-04-08T23:10:54.269659Z","steps":["trace[313450479] 'read index received'  (duration: 115.360446ms)","trace[313450479] 'applied index is now lower than readState.Index'  (duration: 5.747338ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:54.269816Z","caller":"traceutil/trace.go:171","msg":"trace[103228068] transaction","detail":"{read_only:false; response_revision:8192; number_of_response:1; }","duration":"159.058172ms","start":"2026-04-08T23:10:54.110745Z","end":"2026-04-08T23:10:54.269803Z","steps":["trace[103228068] 'process raft request'  (duration: 158.863128ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.269868Z","caller":"traceutil/trace.go:171","msg":"trace[1441215222] transaction","detail":"{read_only:false; response_revision:8191; number_of_response:1; }","duration":"160.318309ms","start":"2026-04-08T23:10:54.1095Z","end":"2026-04-08T23:10:54.269818Z","steps":["trace[1441215222] 'process raft request'  (duration: 159.995372ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:54.27014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.134233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-08T23:10:54.270211Z","caller":"traceutil/trace.go:171","msg":"trace[1355118971] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8192; }","duration":"159.234195ms","start":"2026-04-08T23:10:54.110959Z","end":"2026-04-08T23:10:54.270193Z","steps":["trace[1355118971] 'agreement among raft nodes before linearized reading'  (duration: 159.002599ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:54.270376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.532094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:207034"}
{"level":"info","ts":"2026-04-08T23:10:54.270466Z","caller":"traceutil/trace.go:171","msg":"trace[873824377] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:8192; }","duration":"117.671037ms","start":"2026-04-08T23:10:54.152775Z","end":"2026-04-08T23:10:54.270446Z","steps":["trace[873824377] 'agreement among raft nodes before linearized reading'  (duration: 117.167526ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.461548Z","caller":"traceutil/trace.go:171","msg":"trace[1300552873] transaction","detail":"{read_only:false; response_revision:8199; number_of_response:1; }","duration":"121.482694ms","start":"2026-04-08T23:10:54.340036Z","end":"2026-04-08T23:10:54.461518Z","steps":["trace[1300552873] 'process raft request'  (duration: 32.078017ms)","trace[1300552873] 'compare'  (duration: 89.161131ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:54.462144Z","caller":"traceutil/trace.go:171","msg":"trace[1637888910] linearizableReadLoop","detail":"{readStateIndex:8489; appliedIndex:8484; }","duration":"120.810178ms","start":"2026-04-08T23:10:54.341303Z","end":"2026-04-08T23:10:54.462113Z","steps":["trace[1637888910] 'read index received'  (duration: 30.793958ms)","trace[1637888910] 'applied index is now lower than readState.Index'  (duration: 90.01454ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:54.462304Z","caller":"traceutil/trace.go:171","msg":"trace[44370239] transaction","detail":"{read_only:false; response_revision:8201; number_of_response:1; }","duration":"121.053443ms","start":"2026-04-08T23:10:54.341222Z","end":"2026-04-08T23:10:54.462276Z","steps":["trace[44370239] 'process raft request'  (duration: 120.777857ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:54.462407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.067643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/rook-ceph/\" range_end:\"/registry/resourcequotas/rook-ceph0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:10:54.46246Z","caller":"traceutil/trace.go:171","msg":"trace[571259350] range","detail":"{range_begin:/registry/resourcequotas/rook-ceph/; range_end:/registry/resourcequotas/rook-ceph0; response_count:0; response_revision:8203; }","duration":"121.182366ms","start":"2026-04-08T23:10:54.341261Z","end":"2026-04-08T23:10:54.462444Z","steps":["trace[571259350] 'agreement among raft nodes before linearized reading'  (duration: 120.967041ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.462455Z","caller":"traceutil/trace.go:171","msg":"trace[671629827] transaction","detail":"{read_only:false; response_revision:8200; number_of_response:1; }","duration":"121.297939ms","start":"2026-04-08T23:10:54.341134Z","end":"2026-04-08T23:10:54.462432Z","steps":["trace[671629827] 'process raft request'  (duration: 120.669985ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.462538Z","caller":"traceutil/trace.go:171","msg":"trace[1215937399] transaction","detail":"{read_only:false; response_revision:8202; number_of_response:1; }","duration":"121.142405ms","start":"2026-04-08T23:10:54.341231Z","end":"2026-04-08T23:10:54.462374Z","steps":["trace[1215937399] 'process raft request'  (duration: 120.808618ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.462551Z","caller":"traceutil/trace.go:171","msg":"trace[108179220] transaction","detail":"{read_only:false; response_revision:8203; number_of_response:1; }","duration":"121.279378ms","start":"2026-04-08T23:10:54.341248Z","end":"2026-04-08T23:10:54.462527Z","steps":["trace[108179220] 'process raft request'  (duration: 120.826548ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:54.831234Z","caller":"traceutil/trace.go:171","msg":"trace[1552644615] transaction","detail":"{read_only:false; response_revision:8205; number_of_response:1; }","duration":"299.449947ms","start":"2026-04-08T23:10:54.531748Z","end":"2026-04-08T23:10:54.831198Z","steps":["trace[1552644615] 'process raft request'  (duration: 211.768098ms)","trace[1552644615] 'compare'  (duration: 87.411423ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:54.832677Z","caller":"traceutil/trace.go:171","msg":"trace[1936147749] linearizableReadLoop","detail":"{readStateIndex:8492; appliedIndex:8490; }","duration":"103.498301ms","start":"2026-04-08T23:10:54.729156Z","end":"2026-04-08T23:10:54.832655Z","steps":["trace[1936147749] 'read index received'  (duration: 14.384241ms)","trace[1936147749] 'applied index is now lower than readState.Index'  (duration: 89.11278ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:54.832815Z","caller":"traceutil/trace.go:171","msg":"trace[1734946902] transaction","detail":"{read_only:false; response_revision:8206; number_of_response:1; }","duration":"206.059111ms","start":"2026-04-08T23:10:54.626718Z","end":"2026-04-08T23:10:54.832777Z","steps":["trace[1734946902] 'process raft request'  (duration: 205.805685ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:54.832914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.742586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-04-08T23:10:54.832993Z","caller":"traceutil/trace.go:171","msg":"trace[1870521105] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8206; }","duration":"103.884699ms","start":"2026-04-08T23:10:54.729091Z","end":"2026-04-08T23:10:54.832976Z","steps":["trace[1870521105] 'agreement among raft nodes before linearized reading'  (duration: 103.693745ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:10:58.200692Z","caller":"traceutil/trace.go:171","msg":"trace[1726018691] linearizableReadLoop","detail":"{readStateIndex:8533; appliedIndex:8532; }","duration":"427.480555ms","start":"2026-04-08T23:10:57.773185Z","end":"2026-04-08T23:10:58.200666Z","steps":["trace[1726018691] 'read index received'  (duration: 427.409063ms)","trace[1726018691] 'applied index is now lower than readState.Index'  (duration: 70.492µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:10:58.200813Z","caller":"traceutil/trace.go:171","msg":"trace[1472378710] transaction","detail":"{read_only:false; response_revision:8247; number_of_response:1; }","duration":"436.753202ms","start":"2026-04-08T23:10:57.764047Z","end":"2026-04-08T23:10:58.2008Z","steps":["trace[1472378710] 'process raft request'  (duration: 436.463735ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:58.200945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:57.764016Z","time spent":"436.826883ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8232 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-08T23:10:58.20109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.902274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:10:58.20115Z","caller":"traceutil/trace.go:171","msg":"trace[1275204284] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8247; }","duration":"428.000657ms","start":"2026-04-08T23:10:57.773133Z","end":"2026-04-08T23:10:58.201134Z","steps":["trace[1275204284] 'agreement among raft nodes before linearized reading'  (duration: 427.851684ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:10:58.201186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:57.773114Z","time spent":"428.066368ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-08T23:10:58.701506Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086838640252210,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-08T23:10:59.202141Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086838640252210,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-08T23:11:00.20806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999930976s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-08T23:11:00.208154Z","caller":"traceutil/trace.go:171","msg":"trace[1488357202] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000072279s","start":"2026-04-08T23:10:58.208058Z","end":"2026-04-08T23:11:00.20813Z","steps":["trace[1488357202] 'agreement among raft nodes before linearized reading'  (duration: 1.999964217s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.208197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.20804Z","time spent":"2.000147731s","remote":"127.0.0.1:53846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/08 23:11:00 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-08T23:11:00.377753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.955251ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640252209 > lease_revoke:<id:08529d6f4ef793b2>","response":"size:29"}
{"level":"info","ts":"2026-04-08T23:11:00.393358Z","caller":"traceutil/trace.go:171","msg":"trace[629692582] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"2.187876542s","start":"2026-04-08T23:10:58.205456Z","end":"2026-04-08T23:11:00.393333Z","steps":["trace[629692582] 'process raft request'  (duration: 2.187441423s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.393509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.205441Z","time spent":"2.187987095s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8233 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-08T23:11:00.393618Z","caller":"traceutil/trace.go:171","msg":"trace[1033725953] transaction","detail":"{read_only:false; response_revision:8249; number_of_response:1; }","duration":"1.650270788s","start":"2026-04-08T23:10:58.743322Z","end":"2026-04-08T23:11:00.393592Z","steps":["trace[1033725953] 'process raft request'  (duration: 1.649946771s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.393748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.743296Z","time spent":"1.650378581s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8150 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-04-08T23:11:00.39381Z","caller":"traceutil/trace.go:171","msg":"trace[1136253012] linearizableReadLoop","detail":"{readStateIndex:8537; appliedIndex:8533; }","duration":"2.193029047s","start":"2026-04-08T23:10:58.200762Z","end":"2026-04-08T23:11:00.393791Z","steps":["trace[1136253012] 'read index received'  (duration: 1.197049339s)","trace[1136253012] 'applied index is now lower than readState.Index'  (duration: 995.978798ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:11:00.39393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.619313316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T23:11:00.393886Z","caller":"traceutil/trace.go:171","msg":"trace[473235978] transaction","detail":"{read_only:false; response_revision:8250; number_of_response:1; }","duration":"1.295381054s","start":"2026-04-08T23:10:59.098462Z","end":"2026-04-08T23:11:00.393843Z","steps":["trace[473235978] 'process raft request'  (duration: 1.295159639s)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:00.393967Z","caller":"traceutil/trace.go:171","msg":"trace[1938666256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8250; }","duration":"2.619384697s","start":"2026-04-08T23:10:57.77457Z","end":"2026-04-08T23:11:00.393955Z","steps":["trace[1938666256] 'agreement among raft nodes before linearized reading'  (duration: 2.619252644s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.39399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.619902919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T23:11:00.394031Z","caller":"traceutil/trace.go:171","msg":"trace[1109859231] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8250; }","duration":"2.61997748s","start":"2026-04-08T23:10:57.774044Z","end":"2026-04-08T23:11:00.394022Z","steps":["trace[1109859231] 'agreement among raft nodes before linearized reading'  (duration: 2.619854938s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.394065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:59.098436Z","time spent":"1.295545638s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8244 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-08T23:11:00.393999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:57.774551Z","time spent":"2.619438709s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-08T23:11:00.394095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:57.774037Z","time spent":"2.620032942s","remote":"127.0.0.1:54142","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-08T23:11:00.394883Z","caller":"traceutil/trace.go:171","msg":"trace[300620887] transaction","detail":"{read_only:false; response_revision:8251; number_of_response:1; }","duration":"892.915698ms","start":"2026-04-08T23:10:59.501956Z","end":"2026-04-08T23:11:00.394871Z","steps":["trace[300620887] 'process raft request'  (duration: 892.805666ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.394944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:59.501928Z","time spent":"892.982989ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8246 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-08T23:11:00.395112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.478113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"}
{"level":"warn","ts":"2026-04-08T23:11:00.39512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.111318753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:11:00.395137Z","caller":"traceutil/trace.go:171","msg":"trace[529627382] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8252; }","duration":"422.540525ms","start":"2026-04-08T23:10:59.97259Z","end":"2026-04-08T23:11:00.39513Z","steps":["trace[529627382] 'agreement among raft nodes before linearized reading'  (duration: 422.424922ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.395161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:59.972568Z","time spent":"422.586556ms","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-04-08T23:11:00.39515Z","caller":"traceutil/trace.go:171","msg":"trace[1414814538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8252; }","duration":"2.111376845s","start":"2026-04-08T23:10:58.283766Z","end":"2026-04-08T23:11:00.395142Z","steps":["trace[1414814538] 'agreement among raft nodes before linearized reading'  (duration: 2.111237132s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.395195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.283748Z","time spent":"2.111439906s","remote":"127.0.0.1:54142","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-08T23:11:00.395296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.498314905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T23:11:00.395307Z","caller":"traceutil/trace.go:171","msg":"trace[2070568544] transaction","detail":"{read_only:false; response_revision:8252; number_of_response:1; }","duration":"183.339274ms","start":"2026-04-08T23:11:00.211958Z","end":"2026-04-08T23:11:00.395297Z","steps":["trace[2070568544] 'process raft request'  (duration: 182.861834ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:00.395324Z","caller":"traceutil/trace.go:171","msg":"trace[869345811] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8252; }","duration":"1.498405548s","start":"2026-04-08T23:10:58.896909Z","end":"2026-04-08T23:11:00.395314Z","steps":["trace[869345811] 'agreement among raft nodes before linearized reading'  (duration: 1.498357817s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.39537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.896888Z","time spent":"1.498473359s","remote":"127.0.0.1:54332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T23:11:00.39553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.691328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-08T23:11:00.395595Z","caller":"traceutil/trace.go:171","msg":"trace[286164516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8252; }","duration":"190.803631ms","start":"2026-04-08T23:11:00.204776Z","end":"2026-04-08T23:11:00.395579Z","steps":["trace[286164516] 'agreement among raft nodes before linearized reading'  (duration: 190.601646ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.395721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.334516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T23:11:00.395764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.03636581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:11:00.395784Z","caller":"traceutil/trace.go:171","msg":"trace[1404094954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8252; }","duration":"180.400408ms","start":"2026-04-08T23:11:00.215369Z","end":"2026-04-08T23:11:00.395769Z","steps":["trace[1404094954] 'agreement among raft nodes before linearized reading'  (duration: 180.104801ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:00.395813Z","caller":"traceutil/trace.go:171","msg":"trace[1680476309] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8252; }","duration":"2.036417971s","start":"2026-04-08T23:10:58.359365Z","end":"2026-04-08T23:11:00.395783Z","steps":["trace[1680476309] 'agreement among raft nodes before linearized reading'  (duration: 2.036341889s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.395844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.109050452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:11:00.395868Z","caller":"traceutil/trace.go:171","msg":"trace[1913751004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8252; }","duration":"2.109095854s","start":"2026-04-08T23:10:58.286765Z","end":"2026-04-08T23:11:00.395861Z","steps":["trace[1913751004] 'agreement among raft nodes before linearized reading'  (duration: 2.109030242s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.395888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.286754Z","time spent":"2.109128734s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-08T23:11:00.395859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.359354Z","time spent":"2.036497313s","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-08T23:11:00.395975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.103433187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tlwqz\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T23:11:00.396025Z","caller":"traceutil/trace.go:171","msg":"trace[1698463266] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tlwqz; range_end:; response_count:1; response_revision:8252; }","duration":"2.103508639s","start":"2026-04-08T23:10:58.292502Z","end":"2026-04-08T23:11:00.396011Z","steps":["trace[1698463266] 'agreement among raft nodes before linearized reading'  (duration: 2.103347696s)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:00.396074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:10:58.292494Z","time spent":"2.10357279s","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-tlwqz\" "}
{"level":"info","ts":"2026-04-08T23:11:06.536246Z","caller":"traceutil/trace.go:171","msg":"trace[494742047] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"120.808908ms","start":"2026-04-08T23:11:06.415418Z","end":"2026-04-08T23:11:06.536227Z","steps":["trace[494742047] 'process raft request'  (duration: 120.670405ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:06.64312Z","caller":"traceutil/trace.go:171","msg":"trace[1928814802] linearizableReadLoop","detail":"{readStateIndex:8603; appliedIndex:8601; }","duration":"222.382956ms","start":"2026-04-08T23:11:06.420706Z","end":"2026-04-08T23:11:06.643089Z","steps":["trace[1928814802] 'read index received'  (duration: 115.397667ms)","trace[1928814802] 'applied index is now lower than readState.Index'  (duration: 106.984369ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:11:06.643234Z","caller":"traceutil/trace.go:171","msg":"trace[176029263] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"225.470044ms","start":"2026-04-08T23:11:06.417719Z","end":"2026-04-08T23:11:06.643189Z","steps":["trace[176029263] 'process raft request'  (duration: 224.344439ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:06.643372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.941598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:11:06.643409Z","caller":"traceutil/trace.go:171","msg":"trace[1586877503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8312; }","duration":"219.026371ms","start":"2026-04-08T23:11:06.42437Z","end":"2026-04-08T23:11:06.643397Z","steps":["trace[1586877503] 'agreement among raft nodes before linearized reading'  (duration: 218.874187ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:06.643408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.462791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-08T23:11:06.64347Z","caller":"traceutil/trace.go:171","msg":"trace[166855786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8312; }","duration":"211.553334ms","start":"2026-04-08T23:11:06.431898Z","end":"2026-04-08T23:11:06.643451Z","steps":["trace[166855786] 'agreement among raft nodes before linearized reading'  (duration: 211.36326ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:06.643504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.360338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:11:06.643538Z","caller":"traceutil/trace.go:171","msg":"trace[874746306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8312; }","duration":"215.42423ms","start":"2026-04-08T23:11:06.428104Z","end":"2026-04-08T23:11:06.643528Z","steps":["trace[874746306] 'agreement among raft nodes before linearized reading'  (duration: 215.291828ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:06.643631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.973306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"warn","ts":"2026-04-08T23:11:06.643644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.138246ms","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-08T23:11:06.643686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.818566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T23:11:06.64369Z","caller":"traceutil/trace.go:171","msg":"trace[1594064930] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8312; }","duration":"209.021997ms","start":"2026-04-08T23:11:06.434628Z","end":"2026-04-08T23:11:06.64365Z","steps":["trace[1594064930] 'agreement among raft nodes before linearized reading'  (duration: 208.940545ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:06.643719Z","caller":"traceutil/trace.go:171","msg":"trace[107806480] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8312; }","duration":"212.241008ms","start":"2026-04-08T23:11:06.431466Z","end":"2026-04-08T23:11:06.643707Z","steps":["trace[107806480] 'agreement among raft nodes before linearized reading'  (duration: 212.088595ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:06.643725Z","caller":"traceutil/trace.go:171","msg":"trace[72490778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8312; }","duration":"218.886868ms","start":"2026-04-08T23:11:06.424827Z","end":"2026-04-08T23:11:06.643714Z","steps":["trace[72490778] 'agreement among raft nodes before linearized reading'  (duration: 218.781065ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:06.643713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.490862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tlwqz\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-04-08T23:11:06.643839Z","caller":"traceutil/trace.go:171","msg":"trace[285692072] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tlwqz; range_end:; response_count:1; response_revision:8312; }","duration":"207.698928ms","start":"2026-04-08T23:11:06.436111Z","end":"2026-04-08T23:11:06.64381Z","steps":["trace[285692072] 'agreement among raft nodes before linearized reading'  (duration: 207.215487ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:06.643945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.236594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:11:06.643988Z","caller":"traceutil/trace.go:171","msg":"trace[1871745247] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8312; }","duration":"223.316356ms","start":"2026-04-08T23:11:06.420659Z","end":"2026-04-08T23:11:06.643976Z","steps":["trace[1871745247] 'agreement among raft nodes before linearized reading'  (duration: 223.212034ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:14.678709Z","caller":"traceutil/trace.go:171","msg":"trace[933630344] transaction","detail":"{read_only:false; response_revision:8365; number_of_response:1; }","duration":"110.540059ms","start":"2026-04-08T23:11:14.568142Z","end":"2026-04-08T23:11:14.678682Z","steps":["trace[933630344] 'process raft request'  (duration: 110.320033ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.859612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.259312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:11:14.859694Z","caller":"traceutil/trace.go:171","msg":"trace[2141101148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8366; }","duration":"119.352674ms","start":"2026-04-08T23:11:14.740323Z","end":"2026-04-08T23:11:14.859676Z","steps":["trace[2141101148] 'range keys from in-memory index tree'  (duration: 119.13923ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.859853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.461877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:11:14.859934Z","caller":"traceutil/trace.go:171","msg":"trace[676202514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8366; }","duration":"120.394368ms","start":"2026-04-08T23:11:14.73952Z","end":"2026-04-08T23:11:14.859915Z","steps":["trace[676202514] 'range keys from in-memory index tree'  (duration: 119.242211ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.860001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.819506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-08T23:11:14.860034Z","caller":"traceutil/trace.go:171","msg":"trace[82426168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8366; }","duration":"119.852436ms","start":"2026-04-08T23:11:14.740172Z","end":"2026-04-08T23:11:14.860024Z","steps":["trace[82426168] 'range keys from in-memory index tree'  (duration: 119.602ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.860019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.738193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T23:11:14.860091Z","caller":"traceutil/trace.go:171","msg":"trace[318638509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8366; }","duration":"119.839314ms","start":"2026-04-08T23:11:14.740235Z","end":"2026-04-08T23:11:14.860074Z","steps":["trace[318638509] 'range keys from in-memory index tree'  (duration: 119.599539ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.860163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.794389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T23:11:14.860202Z","caller":"traceutil/trace.go:171","msg":"trace[788103324] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8366; }","duration":"121.875681ms","start":"2026-04-08T23:11:14.738314Z","end":"2026-04-08T23:11:14.86019Z","steps":["trace[788103324] 'range keys from in-memory index tree'  (duration: 121.617375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.86032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.095213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:11:14.860434Z","caller":"traceutil/trace.go:171","msg":"trace[436762928] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8366; }","duration":"121.232767ms","start":"2026-04-08T23:11:14.739169Z","end":"2026-04-08T23:11:14.860401Z","steps":["trace[436762928] 'range keys from in-memory index tree'  (duration: 120.900649ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:14.860361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.459707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-gq57t\" ","response":"range_response_count:1 size:4645"}
{"level":"info","ts":"2026-04-08T23:11:14.86051Z","caller":"traceutil/trace.go:171","msg":"trace[85629598] linearizableReadLoop","detail":"{readStateIndex:8660; appliedIndex:8659; }","duration":"113.750839ms","start":"2026-04-08T23:11:14.746729Z","end":"2026-04-08T23:11:14.86048Z","steps":["trace[85629598] 'read index received'  (duration: 93.576929ms)","trace[85629598] 'applied index is now lower than readState.Index'  (duration: 20.17277ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:11:14.860537Z","caller":"traceutil/trace.go:171","msg":"trace[1479170879] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-gq57t; range_end:; response_count:1; response_revision:8366; }","duration":"119.64487ms","start":"2026-04-08T23:11:14.740878Z","end":"2026-04-08T23:11:14.860523Z","steps":["trace[1479170879] 'range keys from in-memory index tree'  (duration: 119.233721ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:14.860616Z","caller":"traceutil/trace.go:171","msg":"trace[126297759] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"119.17563ms","start":"2026-04-08T23:11:14.741425Z","end":"2026-04-08T23:11:14.860601Z","steps":["trace[126297759] 'process raft request'  (duration: 98.855227ms)","trace[126297759] 'compare'  (duration: 19.854813ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:11:14.860744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.988636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:11:14.860788Z","caller":"traceutil/trace.go:171","msg":"trace[1377006985] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8367; }","duration":"114.063497ms","start":"2026-04-08T23:11:14.746713Z","end":"2026-04-08T23:11:14.860776Z","steps":["trace[1377006985] 'agreement among raft nodes before linearized reading'  (duration: 113.859501ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:15.860883Z","caller":"traceutil/trace.go:171","msg":"trace[1224962816] linearizableReadLoop","detail":"{readStateIndex:8671; appliedIndex:8670; }","duration":"160.545535ms","start":"2026-04-08T23:11:15.700316Z","end":"2026-04-08T23:11:15.860862Z","steps":["trace[1224962816] 'read index received'  (duration: 160.276549ms)","trace[1224962816] 'applied index is now lower than readState.Index'  (duration: 267.926µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:11:15.86101Z","caller":"traceutil/trace.go:171","msg":"trace[1229000385] transaction","detail":"{read_only:false; response_revision:8378; number_of_response:1; }","duration":"162.392635ms","start":"2026-04-08T23:11:15.698607Z","end":"2026-04-08T23:11:15.861Z","steps":["trace[1229000385] 'process raft request'  (duration: 162.100328ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:15.861337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.995835ms","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:5"}
{"level":"info","ts":"2026-04-08T23:11:15.861429Z","caller":"traceutil/trace.go:171","msg":"trace[1487439453] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:8378; }","duration":"161.137278ms","start":"2026-04-08T23:11:15.700269Z","end":"2026-04-08T23:11:15.861407Z","steps":["trace[1487439453] 'agreement among raft nodes before linearized reading'  (duration: 160.926224ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:15.861486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.126011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"}
{"level":"info","ts":"2026-04-08T23:11:15.861618Z","caller":"traceutil/trace.go:171","msg":"trace[959253816] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8378; }","duration":"154.292576ms","start":"2026-04-08T23:11:15.7073Z","end":"2026-04-08T23:11:15.861592Z","steps":["trace[959253816] 'agreement among raft nodes before linearized reading'  (duration: 153.885377ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:16.618832Z","caller":"traceutil/trace.go:171","msg":"trace[351785360] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"199.140437ms","start":"2026-04-08T23:11:16.419652Z","end":"2026-04-08T23:11:16.618792Z","steps":["trace[351785360] 'process raft request'  (duration: 136.807115ms)","trace[351785360] 'compare'  (duration: 61.974554ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:11:17.167531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.934723ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640252610 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-osd.18a48488daf8b5c0\" mod_revision:8380 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-osd.18a48488daf8b5c0\" value_size:587 lease:599714801785475733 >> failure:<request_range:<key:\"/registry/events/openstack/rook-ceph-osd.18a48488daf8b5c0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:11:17.167651Z","caller":"traceutil/trace.go:171","msg":"trace[2100371425] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"542.902552ms","start":"2026-04-08T23:11:16.624723Z","end":"2026-04-08T23:11:17.167626Z","steps":["trace[2100371425] 'process raft request'  (duration: 132.783975ms)","trace[2100371425] 'compare'  (duration: 409.30663ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:11:17.167972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:16.624699Z","time spent":"542.990074ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":662,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-osd.18a48488daf8b5c0\" mod_revision:8380 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-osd.18a48488daf8b5c0\" value_size:587 lease:599714801785475733 >> failure:<request_range:<key:\"/registry/events/openstack/rook-ceph-osd.18a48488daf8b5c0\" > >"}
{"level":"info","ts":"2026-04-08T23:11:17.209356Z","caller":"traceutil/trace.go:171","msg":"trace[1694669611] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"578.353295ms","start":"2026-04-08T23:11:16.630987Z","end":"2026-04-08T23:11:17.20934Z","steps":["trace[1694669611] 'process raft request'  (duration: 578.185611ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.209452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:16.630969Z","time spent":"578.440477ms","remote":"127.0.0.1:40108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5857,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" mod_revision:8215 > success:<request_put:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" value_size:5799 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" > >"}
{"level":"info","ts":"2026-04-08T23:11:17.209716Z","caller":"traceutil/trace.go:171","msg":"trace[2032555737] linearizableReadLoop","detail":"{readStateIndex:8678; appliedIndex:8674; }","duration":"489.739406ms","start":"2026-04-08T23:11:16.71996Z","end":"2026-04-08T23:11:17.2097Z","steps":["trace[2032555737] 'read index received'  (duration: 37.56286ms)","trace[2032555737] 'applied index is now lower than readState.Index'  (duration: 452.169716ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:11:17.209761Z","caller":"traceutil/trace.go:171","msg":"trace[404337385] transaction","detail":"{read_only:false; response_revision:8385; number_of_response:1; }","duration":"497.156571ms","start":"2026-04-08T23:11:16.712576Z","end":"2026-04-08T23:11:17.209733Z","steps":["trace[404337385] 'process raft request'  (duration: 497.013987ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.209815Z","caller":"traceutil/trace.go:171","msg":"trace[99263507] transaction","detail":"{read_only:false; response_revision:8384; number_of_response:1; }","duration":"526.409045ms","start":"2026-04-08T23:11:16.683373Z","end":"2026-04-08T23:11:17.209782Z","steps":["trace[99263507] 'process raft request'  (duration: 525.914594ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.209905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:16.71255Z","time spent":"497.271153ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8366 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-08T23:11:17.209938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.96275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tlwqz\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-04-08T23:11:17.209965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:16.68335Z","time spent":"526.534927ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8365 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-08T23:11:17.210009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.441572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:11:17.210043Z","caller":"traceutil/trace.go:171","msg":"trace[1558303676] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tlwqz; range_end:; response_count:1; response_revision:8385; }","duration":"490.104434ms","start":"2026-04-08T23:11:16.719919Z","end":"2026-04-08T23:11:17.210024Z","steps":["trace[1558303676] 'agreement among raft nodes before linearized reading'  (duration: 489.870919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.210011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.163095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T23:11:17.210058Z","caller":"traceutil/trace.go:171","msg":"trace[512627223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8385; }","duration":"280.506744ms","start":"2026-04-08T23:11:16.929543Z","end":"2026-04-08T23:11:17.210049Z","steps":["trace[512627223] 'agreement among raft nodes before linearized reading'  (duration: 280.398871ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.210126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.216679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-08T23:11:17.210166Z","caller":"traceutil/trace.go:171","msg":"trace[1244322997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8385; }","duration":"281.303601ms","start":"2026-04-08T23:11:16.928856Z","end":"2026-04-08T23:11:17.21016Z","steps":["trace[1244322997] 'agreement among raft nodes before linearized reading'  (duration: 281.213899ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.210157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.90194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:11:17.210175Z","caller":"traceutil/trace.go:171","msg":"trace[2114648496] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8385; }","duration":"280.298628ms","start":"2026-04-08T23:11:16.92982Z","end":"2026-04-08T23:11:17.210119Z","steps":["trace[2114648496] 'agreement among raft nodes before linearized reading'  (duration: 280.090754ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.209922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.177216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:11:17.210263Z","caller":"traceutil/trace.go:171","msg":"trace[1473959204] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8385; }","duration":"280.013102ms","start":"2026-04-08T23:11:16.930211Z","end":"2026-04-08T23:11:17.210224Z","steps":["trace[1473959204] 'agreement among raft nodes before linearized reading'  (duration: 279.774977ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.210093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:16.719908Z","time spent":"490.175275ms","remote":"127.0.0.1:54040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-tlwqz\" "}
{"level":"warn","ts":"2026-04-08T23:11:17.210322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.803598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:11:17.2104Z","caller":"traceutil/trace.go:171","msg":"trace[1768861446] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:8385; }","duration":"133.92362ms","start":"2026-04-08T23:11:17.076438Z","end":"2026-04-08T23:11:17.210361Z","steps":["trace[1768861446] 'agreement among raft nodes before linearized reading'  (duration: 133.781197ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.210458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.267178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-08T23:11:17.210131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.23436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:11:17.210542Z","caller":"traceutil/trace.go:171","msg":"trace[1489015206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8385; }","duration":"280.36782ms","start":"2026-04-08T23:11:16.93016Z","end":"2026-04-08T23:11:17.210528Z","steps":["trace[1489015206] 'agreement among raft nodes before linearized reading'  (duration: 280.160335ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.210676Z","caller":"traceutil/trace.go:171","msg":"trace[510486404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8385; }","duration":"273.787863ms","start":"2026-04-08T23:11:16.936826Z","end":"2026-04-08T23:11:17.210613Z","steps":["trace[510486404] 'agreement among raft nodes before linearized reading'  (duration: 273.058737ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.2103Z","caller":"traceutil/trace.go:171","msg":"trace[1872625471] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8385; }","duration":"327.607515ms","start":"2026-04-08T23:11:16.882676Z","end":"2026-04-08T23:11:17.210283Z","steps":["trace[1872625471] 'agreement among raft nodes before linearized reading'  (duration: 327.141894ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.210955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:11:16.88265Z","time spent":"328.28548ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-04-08T23:11:17.318451Z","caller":"traceutil/trace.go:171","msg":"trace[1193719093] transaction","detail":"{read_only:false; response_revision:8388; number_of_response:1; }","duration":"100.844522ms","start":"2026-04-08T23:11:17.217581Z","end":"2026-04-08T23:11:17.318426Z","steps":["trace[1193719093] 'process raft request'  (duration: 100.74821ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.318476Z","caller":"traceutil/trace.go:171","msg":"trace[1803920639] transaction","detail":"{read_only:false; response_revision:8387; number_of_response:1; }","duration":"100.893403ms","start":"2026-04-08T23:11:17.217525Z","end":"2026-04-08T23:11:17.318419Z","steps":["trace[1803920639] 'process raft request'  (duration: 100.604996ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.318736Z","caller":"traceutil/trace.go:171","msg":"trace[1769974086] transaction","detail":"{read_only:false; response_revision:8389; number_of_response:1; }","duration":"100.950254ms","start":"2026-04-08T23:11:17.217739Z","end":"2026-04-08T23:11:17.318689Z","steps":["trace[1769974086] 'process raft request'  (duration: 100.637578ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.318779Z","caller":"traceutil/trace.go:171","msg":"trace[521845280] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"100.818382ms","start":"2026-04-08T23:11:17.217928Z","end":"2026-04-08T23:11:17.318747Z","steps":["trace[521845280] 'process raft request'  (duration: 100.641628ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.318895Z","caller":"traceutil/trace.go:171","msg":"trace[870954421] linearizableReadLoop","detail":"{readStateIndex:8682; appliedIndex:8678; }","duration":"101.007536ms","start":"2026-04-08T23:11:17.217866Z","end":"2026-04-08T23:11:17.318874Z","steps":["trace[870954421] 'read index received'  (duration: 43.892041ms)","trace[870954421] 'applied index is now lower than readState.Index'  (duration: 57.114825ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:11:17.318926Z","caller":"traceutil/trace.go:171","msg":"trace[936273600] transaction","detail":"{read_only:false; response_revision:8392; number_of_response:1; }","duration":"100.888593ms","start":"2026-04-08T23:11:17.218019Z","end":"2026-04-08T23:11:17.318908Z","steps":["trace[936273600] 'process raft request'  (duration: 100.785111ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.318977Z","caller":"traceutil/trace.go:171","msg":"trace[1712230767] transaction","detail":"{read_only:false; response_revision:8391; number_of_response:1; }","duration":"100.922244ms","start":"2026-04-08T23:11:17.217999Z","end":"2026-04-08T23:11:17.318922Z","steps":["trace[1712230767] 'process raft request'  (duration: 100.694789ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.319071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.185829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:1097"}
{"level":"info","ts":"2026-04-08T23:11:17.319098Z","caller":"traceutil/trace.go:171","msg":"trace[870038743] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8392; }","duration":"101.24326ms","start":"2026-04-08T23:11:17.217844Z","end":"2026-04-08T23:11:17.319087Z","steps":["trace[870038743] 'agreement among raft nodes before linearized reading'  (duration: 101.103557ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:17.947482Z","caller":"traceutil/trace.go:171","msg":"trace[1818617434] linearizableReadLoop","detail":"{readStateIndex:8688; appliedIndex:8687; }","duration":"245.312696ms","start":"2026-04-08T23:11:17.702141Z","end":"2026-04-08T23:11:17.947454Z","steps":["trace[1818617434] 'read index received'  (duration: 245.152343ms)","trace[1818617434] 'applied index is now lower than readState.Index'  (duration: 159.293µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:11:17.94757Z","caller":"traceutil/trace.go:171","msg":"trace[1216173680] transaction","detail":"{read_only:false; response_revision:8395; number_of_response:1; }","duration":"252.775064ms","start":"2026-04-08T23:11:17.694762Z","end":"2026-04-08T23:11:17.947537Z","steps":["trace[1216173680] 'process raft request'  (duration: 252.482498ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.947657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.134067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T23:11:17.947692Z","caller":"traceutil/trace.go:171","msg":"trace[1118610078] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8395; }","duration":"135.244259ms","start":"2026-04-08T23:11:17.812435Z","end":"2026-04-08T23:11:17.947679Z","steps":["trace[1118610078] 'agreement among raft nodes before linearized reading'  (duration: 135.160378ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:17.94785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.695527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112164"}
{"level":"info","ts":"2026-04-08T23:11:17.947915Z","caller":"traceutil/trace.go:171","msg":"trace[1581234610] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:8395; }","duration":"245.772078ms","start":"2026-04-08T23:11:17.702126Z","end":"2026-04-08T23:11:17.947898Z","steps":["trace[1581234610] 'agreement among raft nodes before linearized reading'  (duration: 245.42513ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:11:18.095094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.34211ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640252658 > lease_revoke:<id:08529d6f4ef79568>","response":"size:29"}
{"level":"info","ts":"2026-04-08T23:11:18.131776Z","caller":"traceutil/trace.go:171","msg":"trace[1410194611] transaction","detail":"{read_only:false; response_revision:8396; number_of_response:1; }","duration":"171.679033ms","start":"2026-04-08T23:11:17.960066Z","end":"2026-04-08T23:11:18.131745Z","steps":["trace[1410194611] 'process raft request'  (duration: 171.488649ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:11:26.030762Z","caller":"traceutil/trace.go:171","msg":"trace[1836619529] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"174.859925ms","start":"2026-04-08T23:11:25.855877Z","end":"2026-04-08T23:11:26.030737Z","steps":["trace[1836619529] 'process raft request'  (duration: 174.692131ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:07.3433Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023fc.wal"}
{"level":"info","ts":"2026-04-08T23:12:23.824912Z","caller":"traceutil/trace.go:171","msg":"trace[490159925] linearizableReadLoop","detail":"{readStateIndex:9323; appliedIndex:9322; }","duration":"139.628198ms","start":"2026-04-08T23:12:23.685242Z","end":"2026-04-08T23:12:23.82487Z","steps":["trace[490159925] 'read index received'  (duration: 139.344291ms)","trace[490159925] 'applied index is now lower than readState.Index'  (duration: 282.407µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:12:23.825136Z","caller":"traceutil/trace.go:171","msg":"trace[413022946] transaction","detail":"{read_only:false; response_revision:9012; number_of_response:1; }","duration":"150.188804ms","start":"2026-04-08T23:12:23.674927Z","end":"2026-04-08T23:12:23.825116Z","steps":["trace[413022946] 'process raft request'  (duration: 149.716433ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:23.825373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.106698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:12:23.825465Z","caller":"traceutil/trace.go:171","msg":"trace[1660078507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9012; }","duration":"140.224361ms","start":"2026-04-08T23:12:23.685219Z","end":"2026-04-08T23:12:23.825444Z","steps":["trace[1660078507] 'agreement among raft nodes before linearized reading'  (duration: 139.962316ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:23.955196Z","caller":"traceutil/trace.go:171","msg":"trace[1111950190] linearizableReadLoop","detail":"{readStateIndex:9324; appliedIndex:9323; }","duration":"130.119335ms","start":"2026-04-08T23:12:23.825052Z","end":"2026-04-08T23:12:23.955171Z","steps":["trace[1111950190] 'read index received'  (duration: 130.051413ms)","trace[1111950190] 'applied index is now lower than readState.Index'  (duration: 66.842µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:12:23.955408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.132701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:12:23.955439Z","caller":"traceutil/trace.go:171","msg":"trace[444817466] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:9013; }","duration":"197.233694ms","start":"2026-04-08T23:12:23.758196Z","end":"2026-04-08T23:12:23.95543Z","steps":["trace[444817466] 'agreement among raft nodes before linearized reading'  (duration: 197.09261ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:23.955439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.735564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-08T23:12:23.955518Z","caller":"traceutil/trace.go:171","msg":"trace[41492116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9013; }","duration":"192.885617ms","start":"2026-04-08T23:12:23.762615Z","end":"2026-04-08T23:12:23.955501Z","steps":["trace[41492116] 'agreement among raft nodes before linearized reading'  (duration: 192.602321ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:23.955544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.02242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:12:23.955591Z","caller":"traceutil/trace.go:171","msg":"trace[1386694327] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9013; }","duration":"193.069662ms","start":"2026-04-08T23:12:23.762506Z","end":"2026-04-08T23:12:23.955576Z","steps":["trace[1386694327] 'agreement among raft nodes before linearized reading'  (duration: 192.97799ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:23.955438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.642994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-08T23:12:23.95569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.129018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T23:12:23.955724Z","caller":"traceutil/trace.go:171","msg":"trace[1604360487] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9013; }","duration":"191.21307ms","start":"2026-04-08T23:12:23.764503Z","end":"2026-04-08T23:12:23.955716Z","steps":["trace[1604360487] 'agreement among raft nodes before linearized reading'  (duration: 191.126968ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:23.955647Z","caller":"traceutil/trace.go:171","msg":"trace[1350501458] transaction","detail":"{read_only:false; response_revision:9013; number_of_response:1; }","duration":"195.262401ms","start":"2026-04-08T23:12:23.760305Z","end":"2026-04-08T23:12:23.955567Z","steps":["trace[1350501458] 'process raft request'  (duration: 194.696048ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:23.955732Z","caller":"traceutil/trace.go:171","msg":"trace[689906670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9013; }","duration":"193.93589ms","start":"2026-04-08T23:12:23.761756Z","end":"2026-04-08T23:12:23.955692Z","steps":["trace[689906670] 'agreement among raft nodes before linearized reading'  (duration: 193.530251ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:23.965518Z","caller":"traceutil/trace.go:171","msg":"trace[2068636392] transaction","detail":"{read_only:false; response_revision:9014; number_of_response:1; }","duration":"136.468657ms","start":"2026-04-08T23:12:23.829037Z","end":"2026-04-08T23:12:23.965506Z","steps":["trace[2068636392] 'process raft request'  (duration: 136.382725ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:24.262345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.371415ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640254432 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9003 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:12:24.262833Z","caller":"traceutil/trace.go:171","msg":"trace[556945259] transaction","detail":"{read_only:false; response_revision:9015; number_of_response:1; }","duration":"302.961775ms","start":"2026-04-08T23:12:23.959837Z","end":"2026-04-08T23:12:24.262799Z","steps":["trace[556945259] 'process raft request'  (duration: 88.966606ms)","trace[556945259] 'compare'  (duration: 213.185251ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:12:24.263045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:12:23.95981Z","time spent":"303.111578ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9003 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-08T23:12:24.263133Z","caller":"traceutil/trace.go:171","msg":"trace[759771743] transaction","detail":"{read_only:false; response_revision:9018; number_of_response:1; }","duration":"302.544605ms","start":"2026-04-08T23:12:23.960577Z","end":"2026-04-08T23:12:24.263122Z","steps":["trace[759771743] 'process raft request'  (duration: 302.33514ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:24.263089Z","caller":"traceutil/trace.go:171","msg":"trace[1133545052] transaction","detail":"{read_only:false; response_revision:9017; number_of_response:1; }","duration":"303.030306ms","start":"2026-04-08T23:12:23.960005Z","end":"2026-04-08T23:12:24.263035Z","steps":["trace[1133545052] 'process raft request'  (duration: 302.841302ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:24.263245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.848366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T23:12:24.263265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:12:23.960567Z","time spent":"302.607597ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9002 > 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-08T23:12:24.263302Z","caller":"traceutil/trace.go:171","msg":"trace[833326216] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:9019; }","duration":"166.949799ms","start":"2026-04-08T23:12:24.096336Z","end":"2026-04-08T23:12:24.263286Z","steps":["trace[833326216] 'agreement among raft nodes before linearized reading'  (duration: 166.782905ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:12:24.263037Z","caller":"traceutil/trace.go:171","msg":"trace[689651543] transaction","detail":"{read_only:false; response_revision:9016; number_of_response:1; }","duration":"303.031126ms","start":"2026-04-08T23:12:23.959956Z","end":"2026-04-08T23:12:24.262987Z","steps":["trace[689651543] 'process raft request'  (duration: 302.559076ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:24.263374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:12:23.959994Z","time spent":"303.244111ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:9004 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-08T23:12:24.263417Z","caller":"traceutil/trace.go:171","msg":"trace[1244603699] transaction","detail":"{read_only:false; response_revision:9019; number_of_response:1; }","duration":"302.682678ms","start":"2026-04-08T23:12:23.960722Z","end":"2026-04-08T23:12:24.263405Z","steps":["trace[1244603699] 'process raft request'  (duration: 302.254929ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:12:24.263419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:12:23.959934Z","time spent":"303.420074ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9006 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-08T23:12:24.263471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:12:23.960702Z","time spent":"302.74049ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9005 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-08T23:12:24.263071Z","caller":"traceutil/trace.go:171","msg":"trace[1761436860] linearizableReadLoop","detail":"{readStateIndex:9330; appliedIndex:9325; }","duration":"166.661951ms","start":"2026-04-08T23:12:24.096384Z","end":"2026-04-08T23:12:24.263045Z","steps":["trace[1761436860] 'read index received'  (duration: 56.021µs)","trace[1761436860] 'applied index is now lower than readState.Index'  (duration: 166.60454ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:12:24.263718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.349968ms","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:7"}
{"level":"info","ts":"2026-04-08T23:12:24.263755Z","caller":"traceutil/trace.go:171","msg":"trace[1159474565] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:9019; }","duration":"116.387549ms","start":"2026-04-08T23:12:24.147355Z","end":"2026-04-08T23:12:24.263743Z","steps":["trace[1159474565] 'agreement among raft nodes before linearized reading'  (duration: 116.318517ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:13:11.016852Z","caller":"traceutil/trace.go:171","msg":"trace[795248918] transaction","detail":"{read_only:false; response_revision:9437; number_of_response:1; }","duration":"103.78968ms","start":"2026-04-08T23:13:10.913035Z","end":"2026-04-08T23:13:11.016825Z","steps":["trace[795248918] 'process raft request'  (duration: 77.008084ms)","trace[795248918] 'compare'  (duration: 26.666582ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:13:43.545379Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e10bb51ed7578852","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T23:13:43.551027Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-08T23:13:43.551157Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-08T23:14:42.979301Z","caller":"traceutil/trace.go:171","msg":"trace[816216613] transaction","detail":"{read_only:false; response_revision:10157; number_of_response:1; }","duration":"117.253997ms","start":"2026-04-08T23:14:42.862016Z","end":"2026-04-08T23:14:42.97927Z","steps":["trace[816216613] 'process raft request'  (duration: 117.066323ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:58.303545Z","caller":"traceutil/trace.go:171","msg":"trace[1934816748] transaction","detail":"{read_only:false; response_revision:10278; number_of_response:1; }","duration":"131.955218ms","start":"2026-04-08T23:14:58.17155Z","end":"2026-04-08T23:14:58.303505Z","steps":["trace[1934816748] 'process raft request'  (duration: 131.678732ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:58.38117Z","caller":"traceutil/trace.go:171","msg":"trace[541575813] transaction","detail":"{read_only:false; response_revision:10279; number_of_response:1; }","duration":"164.368119ms","start":"2026-04-08T23:14:58.216764Z","end":"2026-04-08T23:14:58.381132Z","steps":["trace[541575813] 'process raft request'  (duration: 164.036142ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:58.512268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.244823ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640257728 > lease_revoke:<id:08529d6f4ef7a990>","response":"size:29"}
{"level":"info","ts":"2026-04-08T23:14:58.51245Z","caller":"traceutil/trace.go:171","msg":"trace[700838518] linearizableReadLoop","detail":"{readStateIndex:10631; appliedIndex:10629; }","duration":"207.698097ms","start":"2026-04-08T23:14:58.304712Z","end":"2026-04-08T23:14:58.51241Z","steps":["trace[700838518] 'read index received'  (duration: 75.977323ms)","trace[700838518] 'applied index is now lower than readState.Index'  (duration: 131.718734ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:14:58.51258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.85688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:14:58.512661Z","caller":"traceutil/trace.go:171","msg":"trace[1156737027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10279; }","duration":"207.945072ms","start":"2026-04-08T23:14:58.304696Z","end":"2026-04-08T23:14:58.512641Z","steps":["trace[1156737027] 'agreement among raft nodes before linearized reading'  (duration: 207.819999ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:58.512789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.357268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5129"}
{"level":"info","ts":"2026-04-08T23:14:58.512841Z","caller":"traceutil/trace.go:171","msg":"trace[1596866537] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:10279; }","duration":"132.46103ms","start":"2026-04-08T23:14:58.380353Z","end":"2026-04-08T23:14:58.512814Z","steps":["trace[1596866537] 'agreement among raft nodes before linearized reading'  (duration: 132.227215ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.444488Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9823086838640257734,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-08T23:14:59.495101Z","caller":"traceutil/trace.go:171","msg":"trace[132949712] linearizableReadLoop","detail":"{readStateIndex:10632; appliedIndex:10631; }","duration":"551.252977ms","start":"2026-04-08T23:14:58.94382Z","end":"2026-04-08T23:14:59.495073Z","steps":["trace[132949712] 'read index received'  (duration: 551.061983ms)","trace[132949712] 'applied index is now lower than readState.Index'  (duration: 189.894µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:14:59.495159Z","caller":"traceutil/trace.go:171","msg":"trace[1248491111] transaction","detail":"{read_only:false; response_revision:10280; number_of_response:1; }","duration":"707.523008ms","start":"2026-04-08T23:14:58.787596Z","end":"2026-04-08T23:14:59.495119Z","steps":["trace[1248491111] 'process raft request'  (duration: 707.277953ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.495362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:14:58.787579Z","time spent":"707.666142ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:10270 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-08T23:14:59.495403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.015384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:14:59.495452Z","caller":"traceutil/trace.go:171","msg":"trace[1800619138] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:10280; }","duration":"499.213628ms","start":"2026-04-08T23:14:58.996223Z","end":"2026-04-08T23:14:59.495437Z","steps":["trace[1800619138] 'agreement among raft nodes before linearized reading'  (duration: 499.019984ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.495498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:14:58.996199Z","time spent":"499.28827ms","remote":"127.0.0.1:40060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true "}
{"level":"warn","ts":"2026-04-08T23:14:59.495689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.33669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-08T23:14:59.49576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.901952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T23:14:59.495723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.85749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:14:59.495776Z","caller":"traceutil/trace.go:171","msg":"trace[1686877793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:10280; }","duration":"276.459712ms","start":"2026-04-08T23:14:59.219296Z","end":"2026-04-08T23:14:59.495755Z","steps":["trace[1686877793] 'agreement among raft nodes before linearized reading'  (duration: 276.169686ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:59.4958Z","caller":"traceutil/trace.go:171","msg":"trace[539893606] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:10280; }","duration":"456.964454ms","start":"2026-04-08T23:14:59.038822Z","end":"2026-04-08T23:14:59.495787Z","steps":["trace[539893606] 'agreement among raft nodes before linearized reading'  (duration: 456.897342ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.495835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:14:59.03881Z","time spent":"457.015835ms","remote":"127.0.0.1:43388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"info","ts":"2026-04-08T23:14:59.495842Z","caller":"traceutil/trace.go:171","msg":"trace[1684971344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10280; }","duration":"552.038274ms","start":"2026-04-08T23:14:58.943772Z","end":"2026-04-08T23:14:59.49581Z","steps":["trace[1684971344] 'agreement among raft nodes before linearized reading'  (duration: 551.405811ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.4959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:14:58.943748Z","time spent":"552.140967ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-08T23:14:59.495861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.592101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-08T23:14:59.495901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.015263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-08T23:14:59.495976Z","caller":"traceutil/trace.go:171","msg":"trace[1226583971] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:10280; }","duration":"303.135305ms","start":"2026-04-08T23:14:59.192819Z","end":"2026-04-08T23:14:59.495954Z","steps":["trace[1226583971] 'agreement among raft nodes before linearized reading'  (duration: 302.87149ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.495954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.335636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-04-08T23:14:59.496022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:14:59.192799Z","time spent":"303.214968ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-04-08T23:14:59.496053Z","caller":"traceutil/trace.go:171","msg":"trace[1750019132] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:10280; }","duration":"279.470149ms","start":"2026-04-08T23:14:59.216554Z","end":"2026-04-08T23:14:59.496024Z","steps":["trace[1750019132] 'agreement among raft nodes before linearized reading'  (duration: 279.145412ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:59.496016Z","caller":"traceutil/trace.go:171","msg":"trace[1202532931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10280; }","duration":"306.783095ms","start":"2026-04-08T23:14:59.189164Z","end":"2026-04-08T23:14:59.495947Z","steps":["trace[1202532931] 'agreement among raft nodes before linearized reading'  (duration: 306.343696ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.496235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.391535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-08T23:14:59.496842Z","caller":"traceutil/trace.go:171","msg":"trace[229017902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10280; }","duration":"285.07623ms","start":"2026-04-08T23:14:59.211738Z","end":"2026-04-08T23:14:59.496814Z","steps":["trace[229017902] 'agreement among raft nodes before linearized reading'  (duration: 283.66973ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:14:59.496885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:14:59.189143Z","time spent":"307.674205ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-08T23:14:59.641795Z","caller":"traceutil/trace.go:171","msg":"trace[1613621560] transaction","detail":"{read_only:false; response_revision:10283; number_of_response:1; }","duration":"141.226691ms","start":"2026-04-08T23:14:59.50052Z","end":"2026-04-08T23:14:59.641747Z","steps":["trace[1613621560] 'process raft request'  (duration: 141.067107ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:59.641978Z","caller":"traceutil/trace.go:171","msg":"trace[781618660] transaction","detail":"{read_only:false; response_revision:10285; number_of_response:1; }","duration":"140.873364ms","start":"2026-04-08T23:14:59.501073Z","end":"2026-04-08T23:14:59.641947Z","steps":["trace[781618660] 'process raft request'  (duration: 140.66491ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:59.641758Z","caller":"traceutil/trace.go:171","msg":"trace[315903892] transaction","detail":"{read_only:false; response_revision:10282; number_of_response:1; }","duration":"141.490077ms","start":"2026-04-08T23:14:59.50023Z","end":"2026-04-08T23:14:59.64172Z","steps":["trace[315903892] 'process raft request'  (duration: 141.226822ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:59.641823Z","caller":"traceutil/trace.go:171","msg":"trace[1329318504] transaction","detail":"{read_only:false; response_revision:10284; number_of_response:1; }","duration":"140.957426ms","start":"2026-04-08T23:14:59.500841Z","end":"2026-04-08T23:14:59.641798Z","steps":["trace[1329318504] 'process raft request'  (duration: 140.837953ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:14:59.64223Z","caller":"traceutil/trace.go:171","msg":"trace[353307142] transaction","detail":"{read_only:false; response_revision:10286; number_of_response:1; }","duration":"139.437542ms","start":"2026-04-08T23:14:59.502773Z","end":"2026-04-08T23:14:59.642211Z","steps":["trace[353307142] 'process raft request'  (duration: 139.086634ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:15:00.184542Z","caller":"traceutil/trace.go:171","msg":"trace[643012704] transaction","detail":"{read_only:false; response_revision:10288; number_of_response:1; }","duration":"106.587464ms","start":"2026-04-08T23:15:00.077922Z","end":"2026-04-08T23:15:00.184509Z","steps":["trace[643012704] 'process raft request'  (duration: 106.225326ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:15:39.802332Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8106}
{"level":"info","ts":"2026-04-08T23:15:39.87445Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8106,"took":"70.535314ms","hash":3955736019,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":29016064,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-08T23:15:39.874525Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3955736019,"revision":8106,"compact-revision":5947}
{"level":"warn","ts":"2026-04-08T23:15:40.839801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.111495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-08T23:15:40.839937Z","caller":"traceutil/trace.go:171","msg":"trace[704191639] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:10514; }","duration":"244.244908ms","start":"2026-04-08T23:15:40.595647Z","end":"2026-04-08T23:15:40.839892Z","steps":["trace[704191639] 'count revisions from in-memory index tree'  (duration: 244.002153ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:15:40.840438Z","caller":"traceutil/trace.go:171","msg":"trace[220431801] linearizableReadLoop","detail":"{readStateIndex:10876; appliedIndex:10875; }","duration":"173.205941ms","start":"2026-04-08T23:15:40.666756Z","end":"2026-04-08T23:15:40.839962Z","steps":["trace[220431801] 'read index received'  (duration: 171.874232ms)","trace[220431801] 'applied index is now lower than readState.Index'  (duration: 1.329589ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:15:40.840752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.977979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5129"}
{"level":"info","ts":"2026-04-08T23:15:40.840818Z","caller":"traceutil/trace.go:171","msg":"trace[281180660] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:10515; }","duration":"174.098261ms","start":"2026-04-08T23:15:40.666701Z","end":"2026-04-08T23:15:40.8408Z","steps":["trace[281180660] 'agreement among raft nodes before linearized reading'  (duration: 173.823266ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:15:40.841038Z","caller":"traceutil/trace.go:171","msg":"trace[695683793] transaction","detail":"{read_only:false; response_revision:10515; number_of_response:1; }","duration":"230.839313ms","start":"2026-04-08T23:15:40.609996Z","end":"2026-04-08T23:15:40.840835Z","steps":["trace[695683793] 'process raft request'  (duration: 228.666676ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:16:02.72601Z","caller":"traceutil/trace.go:171","msg":"trace[882446356] linearizableReadLoop","detail":"{readStateIndex:10997; appliedIndex:10996; }","duration":"102.37322ms","start":"2026-04-08T23:16:02.623609Z","end":"2026-04-08T23:16:02.725982Z","steps":["trace[882446356] 'read index received'  (duration: 102.208727ms)","trace[882446356] 'applied index is now lower than readState.Index'  (duration: 163.063µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:16:02.726084Z","caller":"traceutil/trace.go:171","msg":"trace[1249752211] transaction","detail":"{read_only:false; response_revision:10631; number_of_response:1; }","duration":"168.635752ms","start":"2026-04-08T23:16:02.557409Z","end":"2026-04-08T23:16:02.726044Z","steps":["trace[1249752211] 'process raft request'  (duration: 168.385426ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:16:02.726202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.557285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T23:16:02.726299Z","caller":"traceutil/trace.go:171","msg":"trace[436602910] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:10631; }","duration":"102.709747ms","start":"2026-04-08T23:16:02.623563Z","end":"2026-04-08T23:16:02.726273Z","steps":["trace[436602910] 'agreement among raft nodes before linearized reading'  (duration: 102.525783ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:16:44.824805Z","caller":"traceutil/trace.go:171","msg":"trace[1289507344] transaction","detail":"{read_only:false; response_revision:10851; number_of_response:1; }","duration":"126.453646ms","start":"2026-04-08T23:16:44.698321Z","end":"2026-04-08T23:16:44.824775Z","steps":["trace[1289507344] 'process raft request'  (duration: 126.282983ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:17:16.617804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.208139ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9823086838640259968 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:11006 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T23:17:16.618072Z","caller":"traceutil/trace.go:171","msg":"trace[2069453091] transaction","detail":"{read_only:false; response_revision:11016; number_of_response:1; }","duration":"206.901453ms","start":"2026-04-08T23:17:16.41114Z","end":"2026-04-08T23:17:16.618042Z","steps":["trace[2069453091] 'process raft request'  (duration: 100.962478ms)","trace[2069453091] 'compare'  (duration: 105.050866ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:17:16.618089Z","caller":"traceutil/trace.go:171","msg":"trace[2025195563] linearizableReadLoop","detail":"{readStateIndex:11400; appliedIndex:11397; }","duration":"199.94626ms","start":"2026-04-08T23:17:16.418123Z","end":"2026-04-08T23:17:16.61807Z","steps":["trace[2025195563] 'read index received'  (duration: 93.970784ms)","trace[2025195563] 'applied index is now lower than readState.Index'  (duration: 105.973946ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:17:16.618397Z","caller":"traceutil/trace.go:171","msg":"trace[1953162926] transaction","detail":"{read_only:false; response_revision:11017; number_of_response:1; }","duration":"206.864551ms","start":"2026-04-08T23:17:16.4115Z","end":"2026-04-08T23:17:16.618364Z","steps":["trace[1953162926] 'process raft request'  (duration: 206.458672ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:17:16.618673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.816292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-04-08T23:17:16.618758Z","caller":"traceutil/trace.go:171","msg":"trace[1401788368] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11018; }","duration":"165.954144ms","start":"2026-04-08T23:17:16.452781Z","end":"2026-04-08T23:17:16.618736Z","steps":["trace[1401788368] 'agreement among raft nodes before linearized reading'  (duration: 165.591675ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:17:16.618841Z","caller":"traceutil/trace.go:171","msg":"trace[1062788468] transaction","detail":"{read_only:false; response_revision:11018; number_of_response:1; }","duration":"207.24983ms","start":"2026-04-08T23:17:16.411538Z","end":"2026-04-08T23:17:16.618788Z","steps":["trace[1062788468] 'process raft request'  (duration: 206.487413ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:17:16.619141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.994123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-04-08T23:17:16.61924Z","caller":"traceutil/trace.go:171","msg":"trace[1995391532] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:11018; }","duration":"201.143077ms","start":"2026-04-08T23:17:16.418073Z","end":"2026-04-08T23:17:16.619216Z","steps":["trace[1995391532] 'agreement among raft nodes before linearized reading'  (duration: 200.84965ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:18:19.108666Z","caller":"traceutil/trace.go:171","msg":"trace[1953662469] linearizableReadLoop","detail":"{readStateIndex:11728; appliedIndex:11727; }","duration":"166.747901ms","start":"2026-04-08T23:18:18.941885Z","end":"2026-04-08T23:18:19.108633Z","steps":["trace[1953662469] 'read index received'  (duration: 166.529266ms)","trace[1953662469] 'applied index is now lower than readState.Index'  (duration: 217.095µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T23:18:19.108801Z","caller":"traceutil/trace.go:171","msg":"trace[1275376874] transaction","detail":"{read_only:false; response_revision:11333; number_of_response:1; }","duration":"170.464083ms","start":"2026-04-08T23:18:18.938325Z","end":"2026-04-08T23:18:19.108789Z","steps":["trace[1275376874] 'process raft request'  (duration: 169.8934ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:18:19.10909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.170202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-08T23:18:19.109205Z","caller":"traceutil/trace.go:171","msg":"trace[190080435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11333; }","duration":"167.345965ms","start":"2026-04-08T23:18:18.941834Z","end":"2026-04-08T23:18:19.10918Z","steps":["trace[190080435] 'agreement among raft nodes before linearized reading'  (duration: 167.023768ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:18:19.248482Z","caller":"traceutil/trace.go:171","msg":"trace[493842204] transaction","detail":"{read_only:false; response_revision:11334; number_of_response:1; }","duration":"285.375005ms","start":"2026-04-08T23:18:18.963068Z","end":"2026-04-08T23:18:19.248443Z","steps":["trace[493842204] 'process raft request'  (duration: 282.245177ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:18:19.248578Z","caller":"traceutil/trace.go:171","msg":"trace[501673428] linearizableReadLoop","detail":"{readStateIndex:11729; appliedIndex:11728; }","duration":"139.796798ms","start":"2026-04-08T23:18:19.108749Z","end":"2026-04-08T23:18:19.248546Z","steps":["trace[501673428] 'read index received'  (duration: 136.69942ms)","trace[501673428] 'applied index is now lower than readState.Index'  (duration: 3.094088ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T23:18:19.248997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.095805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"}
{"level":"warn","ts":"2026-04-08T23:18:19.24902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.275745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-04-08T23:18:19.249088Z","caller":"traceutil/trace.go:171","msg":"trace[751114180] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11335; }","duration":"129.227069ms","start":"2026-04-08T23:18:19.11984Z","end":"2026-04-08T23:18:19.249067Z","steps":["trace[751114180] 'agreement among raft nodes before linearized reading'  (duration: 128.913311ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T23:18:19.249097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.500082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-08T23:18:19.249119Z","caller":"traceutil/trace.go:171","msg":"trace[1237543913] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11335; }","duration":"219.429678ms","start":"2026-04-08T23:18:19.029663Z","end":"2026-04-08T23:18:19.249092Z","steps":["trace[1237543913] 'agreement among raft nodes before linearized reading'  (duration: 218.983847ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:18:19.249146Z","caller":"traceutil/trace.go:171","msg":"trace[206675030] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:11335; }","duration":"230.610834ms","start":"2026-04-08T23:18:19.018518Z","end":"2026-04-08T23:18:19.249129Z","steps":["trace[206675030] 'agreement among raft nodes before linearized reading'  (duration: 230.166263ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:18:19.249238Z","caller":"traceutil/trace.go:171","msg":"trace[867409669] transaction","detail":"{read_only:false; response_revision:11335; number_of_response:1; }","duration":"136.028177ms","start":"2026-04-08T23:18:19.113184Z","end":"2026-04-08T23:18:19.249212Z","steps":["trace[867409669] 'process raft request'  (duration: 135.197228ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T23:20:39.808333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10506}
{"level":"info","ts":"2026-04-08T23:20:39.89013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10506,"took":"80.212946ms","hash":907220009,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":19996672,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-08T23:20:39.890192Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":907220009,"revision":10506,"compact-revision":8106}