{"level":"warn","ts":"2026-04-22T06:03:49.600805Z","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-22T06:03:49.600918Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-22T06:03:49.601016Z","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-22T06:03:49.601034Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-04-22T06:03:49.601063Z","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-22T06:03:49.601853Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]}
{"level":"info","ts":"2026-04-22T06:03:49.601935Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-22T06:03:49.608988Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.798813ms"}
{"level":"info","ts":"2026-04-22T06:03:49.616096Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"}
{"level":"info","ts":"2026-04-22T06:03:49.616229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"}
{"level":"info","ts":"2026-04-22T06:03:49.616262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"}
{"level":"info","ts":"2026-04-22T06:03:49.616288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-22T06:03:49.616301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"}
{"level":"info","ts":"2026-04-22T06:03:49.616352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"warn","ts":"2026-04-22T06:03:49.623668Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-22T06:03:49.625465Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-22T06:03:49.629103Z","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-22T06:03:49.632119Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-22T06:03:49.63235Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-22T06:03:49.632507Z","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-22T06:03:49.632705Z","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-22T06:03:49.632793Z","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-22T06:03:49.63526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"info","ts":"2026-04-22T06:03:49.635439Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-04-22T06:03:49.636214Z","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-22T06:03:49.636511Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-22T06:03:49.636559Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-22T06:03:49.636953Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-04-22T06:03:49.637005Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-04-22T06:03:49.81736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"}
{"level":"info","ts":"2026-04-22T06:03:49.817499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-22T06:03:49.817595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"}
{"level":"info","ts":"2026-04-22T06:03:49.817652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"}
{"level":"info","ts":"2026-04-22T06:03:49.817698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-04-22T06:03:49.817746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"}
{"level":"info","ts":"2026-04-22T06:03:49.817785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-04-22T06:03:49.819232Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-22T06:03:49.819285Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T06:03:49.819354Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T06:03:49.819423Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T06:03:49.819752Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-22T06:03:49.81992Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-22T06:03:49.820559Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T06:03:49.820662Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T06:03:49.820712Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T06:03:49.823344Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-22T06:03:49.823467Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"}
{"level":"warn","ts":"2026-04-22T06:04:08.396965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.354117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:04:08.397088Z","caller":"traceutil/trace.go:171","msg":"trace[1779585027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"114.584021ms","start":"2026-04-22T06:04:08.282481Z","end":"2026-04-22T06:04:08.397065Z","steps":["trace[1779585027] 'range keys from in-memory index tree'  (duration: 114.159533ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:13.755768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.439162ms","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-22T06:04:13.755874Z","caller":"traceutil/trace.go:171","msg":"trace[180263166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:459; }","duration":"178.599154ms","start":"2026-04-22T06:04:13.57725Z","end":"2026-04-22T06:04:13.755849Z","steps":["trace[180263166] 'range keys from in-memory index tree'  (duration: 178.317899ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:04:25.877872Z","caller":"traceutil/trace.go:171","msg":"trace[665537611] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"228.531351ms","start":"2026-04-22T06:04:25.649293Z","end":"2026-04-22T06:04:25.877824Z","steps":["trace[665537611] 'read index received'  (duration: 223.336436ms)","trace[665537611] 'applied index is now lower than readState.Index'  (duration: 5.193725ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:04:25.877964Z","caller":"traceutil/trace.go:171","msg":"trace[70777073] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"388.139489ms","start":"2026-04-22T06:04:25.489789Z","end":"2026-04-22T06:04:25.877928Z","steps":["trace[70777073] 'process raft request'  (duration: 386.169763ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:25.878026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.723234ms","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-22T06:04:25.878059Z","caller":"traceutil/trace.go:171","msg":"trace[1278742922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:612; }","duration":"228.804786ms","start":"2026-04-22T06:04:25.649244Z","end":"2026-04-22T06:04:25.878049Z","steps":["trace[1278742922] 'agreement among raft nodes before linearized reading'  (duration: 228.689744ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:25.878557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:25.489762Z","time spent":"388.289252ms","remote":"127.0.0.1:53024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:608 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-04-22T06:04:25.912778Z","caller":"traceutil/trace.go:171","msg":"trace[83191949] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"248.28838ms","start":"2026-04-22T06:04:25.664467Z","end":"2026-04-22T06:04:25.912756Z","steps":["trace[83191949] 'process raft request'  (duration: 248.153667ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:26.561709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.369654ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093068555 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:04:26.561831Z","caller":"traceutil/trace.go:171","msg":"trace[2127847478] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"515.537054ms","start":"2026-04-22T06:04:26.046269Z","end":"2026-04-22T06:04:26.561806Z","steps":["trace[2127847478] 'read index received'  (duration: 273.658771ms)","trace[2127847478] 'applied index is now lower than readState.Index'  (duration: 241.877053ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:04:26.561915Z","caller":"traceutil/trace.go:171","msg":"trace[939359706] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"623.989673ms","start":"2026-04-22T06:04:25.937915Z","end":"2026-04-22T06:04:26.561905Z","steps":["trace[939359706] 'process raft request'  (duration: 382.10177ms)","trace[939359706] 'compare'  (duration: 241.19319ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:04:26.562143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.842229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zmrjf\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-04-22T06:04:26.562193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.623252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-04-22T06:04:26.562255Z","caller":"traceutil/trace.go:171","msg":"trace[14138468] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zmrjf; range_end:; response_count:1; response_revision:616; }","duration":"516.011012ms","start":"2026-04-22T06:04:26.046216Z","end":"2026-04-22T06:04:26.562228Z","steps":["trace[14138468] 'agreement among raft nodes before linearized reading'  (duration: 515.799149ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:04:26.562261Z","caller":"traceutil/trace.go:171","msg":"trace[163468151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"304.742525ms","start":"2026-04-22T06:04:26.257499Z","end":"2026-04-22T06:04:26.562241Z","steps":["trace[163468151] 'agreement among raft nodes before linearized reading'  (duration: 304.46146ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:26.562134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:25.937897Z","time spent":"624.200757ms","remote":"127.0.0.1:53454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T06:04:26.562314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:26.257472Z","time spent":"304.830307ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-22T06:04:26.562316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:26.046201Z","time spent":"516.101125ms","remote":"127.0.0.1:53124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-zmrjf\" "}
{"level":"warn","ts":"2026-04-22T06:04:26.562915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.459312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:04:26.562979Z","caller":"traceutil/trace.go:171","msg":"trace[339539005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"282.012752ms","start":"2026-04-22T06:04:26.280949Z","end":"2026-04-22T06:04:26.562962Z","steps":["trace[339539005] 'agreement among raft nodes before linearized reading'  (duration: 281.103515ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:41.67162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.230259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:04:41.671734Z","caller":"traceutil/trace.go:171","msg":"trace[234741132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:773; }","duration":"389.404123ms","start":"2026-04-22T06:04:41.282312Z","end":"2026-04-22T06:04:41.671716Z","steps":["trace[234741132] 'range keys from in-memory index tree'  (duration: 389.110198ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:04:41.671779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:41.282289Z","time spent":"389.481674ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-22T06:05:20.384679Z","caller":"traceutil/trace.go:171","msg":"trace[196709645] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"112.113181ms","start":"2026-04-22T06:05:20.272541Z","end":"2026-04-22T06:05:20.384654Z","steps":["trace[196709645] 'read index received'  (duration: 111.898568ms)","trace[196709645] 'applied index is now lower than readState.Index'  (duration: 213.523µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:20.384764Z","caller":"traceutil/trace.go:171","msg":"trace[1621412877] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"127.063538ms","start":"2026-04-22T06:05:20.257666Z","end":"2026-04-22T06:05:20.384729Z","steps":["trace[1621412877] 'process raft request'  (duration: 126.828403ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:20.385014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.975609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T06:05:20.385016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.395838ms","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-22T06:05:20.38506Z","caller":"traceutil/trace.go:171","msg":"trace[208772475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1295; }","duration":"103.0576ms","start":"2026-04-22T06:05:20.28199Z","end":"2026-04-22T06:05:20.385048Z","steps":["trace[208772475] 'agreement among raft nodes before linearized reading'  (duration: 102.972988ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:20.385066Z","caller":"traceutil/trace.go:171","msg":"trace[894431436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1295; }","duration":"112.54608ms","start":"2026-04-22T06:05:20.272507Z","end":"2026-04-22T06:05:20.385053Z","steps":["trace[894431436] 'agreement among raft nodes before linearized reading'  (duration: 112.301696ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:35.830291Z","caller":"traceutil/trace.go:171","msg":"trace[1122448543] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"121.058751ms","start":"2026-04-22T06:05:35.709184Z","end":"2026-04-22T06:05:35.830243Z","steps":["trace[1122448543] 'process raft request'  (duration: 115.641825ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.042432Z","caller":"traceutil/trace.go:171","msg":"trace[787441421] transaction","detail":"{read_only:false; response_revision:1534; number_of_response:1; }","duration":"109.73469ms","start":"2026-04-22T06:05:35.932669Z","end":"2026-04-22T06:05:36.042404Z","steps":["trace[787441421] 'process raft request'  (duration: 109.589446ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.216372Z","caller":"traceutil/trace.go:171","msg":"trace[1165731727] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"283.35802ms","start":"2026-04-22T06:05:35.932975Z","end":"2026-04-22T06:05:36.216333Z","steps":["trace[1165731727] 'process raft request'  (duration: 283.217498ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.216409Z","caller":"traceutil/trace.go:171","msg":"trace[1029415363] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"283.506573ms","start":"2026-04-22T06:05:35.932868Z","end":"2026-04-22T06:05:36.216374Z","steps":["trace[1029415363] 'process raft request'  (duration: 227.876789ms)","trace[1029415363] 'compare'  (duration: 55.295188ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:36.216436Z","caller":"traceutil/trace.go:171","msg":"trace[1161449643] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"282.192359ms","start":"2026-04-22T06:05:35.934216Z","end":"2026-04-22T06:05:36.216409Z","steps":["trace[1161449643] 'process raft request'  (duration: 282.150689ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.216474Z","caller":"traceutil/trace.go:171","msg":"trace[1002685462] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"283.274578ms","start":"2026-04-22T06:05:35.933166Z","end":"2026-04-22T06:05:36.21644Z","steps":["trace[1002685462] 'process raft request'  (duration: 283.101545ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.216567Z","caller":"traceutil/trace.go:171","msg":"trace[506619972] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"283.216357ms","start":"2026-04-22T06:05:35.933268Z","end":"2026-04-22T06:05:36.216484Z","steps":["trace[506619972] 'process raft request'  (duration: 283.031613ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.216656Z","caller":"traceutil/trace.go:171","msg":"trace[1386963143] transaction","detail":"{read_only:false; response_revision:1537; number_of_response:1; }","duration":"283.510243ms","start":"2026-04-22T06:05:35.933089Z","end":"2026-04-22T06:05:36.2166Z","steps":["trace[1386963143] 'process raft request'  (duration: 283.145496ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.216657Z","caller":"traceutil/trace.go:171","msg":"trace[1298236001] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"282.424473ms","start":"2026-04-22T06:05:35.934143Z","end":"2026-04-22T06:05:36.216568Z","steps":["trace[1298236001] 'process raft request'  (duration: 282.188989ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.247386Z","caller":"traceutil/trace.go:171","msg":"trace[439125386] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"194.058295ms","start":"2026-04-22T06:05:36.053299Z","end":"2026-04-22T06:05:36.247358Z","steps":["trace[439125386] 'process raft request'  (duration: 193.730589ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.351925Z","caller":"traceutil/trace.go:171","msg":"trace[219207260] transaction","detail":"{read_only:false; response_revision:1543; number_of_response:1; }","duration":"129.533894ms","start":"2026-04-22T06:05:36.222359Z","end":"2026-04-22T06:05:36.351892Z","steps":["trace[219207260] 'process raft request'  (duration: 128.951793ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.35202Z","caller":"traceutil/trace.go:171","msg":"trace[691594892] transaction","detail":"{read_only:false; response_revision:1546; number_of_response:1; }","duration":"125.203906ms","start":"2026-04-22T06:05:36.226796Z","end":"2026-04-22T06:05:36.352Z","steps":["trace[691594892] 'process raft request'  (duration: 125.147415ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.35217Z","caller":"traceutil/trace.go:171","msg":"trace[545116623] transaction","detail":"{read_only:false; response_revision:1544; number_of_response:1; }","duration":"129.711386ms","start":"2026-04-22T06:05:36.222447Z","end":"2026-04-22T06:05:36.352158Z","steps":["trace[545116623] 'process raft request'  (duration: 129.386311ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.352221Z","caller":"traceutil/trace.go:171","msg":"trace[802823663] transaction","detail":"{read_only:false; response_revision:1545; number_of_response:1; }","duration":"127.369625ms","start":"2026-04-22T06:05:36.22483Z","end":"2026-04-22T06:05:36.3522Z","steps":["trace[802823663] 'process raft request'  (duration: 127.041919ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.381804Z","caller":"traceutil/trace.go:171","msg":"trace[1220173625] linearizableReadLoop","detail":"{readStateIndex:1610; appliedIndex:1604; }","duration":"100.956823ms","start":"2026-04-22T06:05:36.280826Z","end":"2026-04-22T06:05:36.381783Z","steps":["trace[1220173625] 'read index received'  (duration: 70.465208ms)","trace[1220173625] 'applied index is now lower than readState.Index'  (duration: 30.490145ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:36.381879Z","caller":"traceutil/trace.go:171","msg":"trace[2122224309] transaction","detail":"{read_only:false; response_revision:1548; number_of_response:1; }","duration":"124.736597ms","start":"2026-04-22T06:05:36.257116Z","end":"2026-04-22T06:05:36.381853Z","steps":["trace[2122224309] 'process raft request'  (duration: 124.609545ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:36.381977Z","caller":"traceutil/trace.go:171","msg":"trace[1065298330] transaction","detail":"{read_only:false; response_revision:1547; number_of_response:1; }","duration":"130.903207ms","start":"2026-04-22T06:05:36.251057Z","end":"2026-04-22T06:05:36.38196Z","steps":["trace[1065298330] 'process raft request'  (duration: 130.53668ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:36.382289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.452351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:05:36.382352Z","caller":"traceutil/trace.go:171","msg":"trace[31216207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1548; }","duration":"101.557323ms","start":"2026-04-22T06:05:36.280783Z","end":"2026-04-22T06:05:36.38234Z","steps":["trace[31216207] 'agreement among raft nodes before linearized reading'  (duration: 101.108666ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:38.874366Z","caller":"traceutil/trace.go:171","msg":"trace[1021850693] linearizableReadLoop","detail":"{readStateIndex:1706; appliedIndex:1705; }","duration":"138.199132ms","start":"2026-04-22T06:05:38.73613Z","end":"2026-04-22T06:05:38.87433Z","steps":["trace[1021850693] 'read index received'  (duration: 113.558058ms)","trace[1021850693] 'applied index is now lower than readState.Index'  (duration: 24.638924ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:38.874404Z","caller":"traceutil/trace.go:171","msg":"trace[1166764447] transaction","detail":"{read_only:false; response_revision:1640; number_of_response:1; }","duration":"160.37777ms","start":"2026-04-22T06:05:38.71398Z","end":"2026-04-22T06:05:38.874358Z","steps":["trace[1166764447] 'process raft request'  (duration: 135.691036ms)","trace[1166764447] 'compare'  (duration: 24.45286ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:05:38.874523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.361504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:05:38.874784Z","caller":"traceutil/trace.go:171","msg":"trace[55438080] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com; range_end:; response_count:0; response_revision:1640; }","duration":"138.503636ms","start":"2026-04-22T06:05:38.736079Z","end":"2026-04-22T06:05:38.874583Z","steps":["trace[55438080] 'agreement among raft nodes before linearized reading'  (duration: 138.376664ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:45.311618Z","caller":"traceutil/trace.go:171","msg":"trace[64014498] linearizableReadLoop","detail":"{readStateIndex:1779; appliedIndex:1778; }","duration":"277.629445ms","start":"2026-04-22T06:05:45.033962Z","end":"2026-04-22T06:05:45.311592Z","steps":["trace[64014498] 'read index received'  (duration: 277.432171ms)","trace[64014498] 'applied index is now lower than readState.Index'  (duration: 196.194µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:45.311711Z","caller":"traceutil/trace.go:171","msg":"trace[1097527192] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"278.885127ms","start":"2026-04-22T06:05:45.032799Z","end":"2026-04-22T06:05:45.311684Z","steps":["trace[1097527192] 'process raft request'  (duration: 278.575292ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:45.311891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.91928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-04-22T06:05:45.311935Z","caller":"traceutil/trace.go:171","msg":"trace[844315842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1708; }","duration":"278.026882ms","start":"2026-04-22T06:05:45.033897Z","end":"2026-04-22T06:05:45.311924Z","steps":["trace[844315842] 'agreement among raft nodes before linearized reading'  (duration: 277.838409ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:45.311957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.902709ms","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-22T06:05:45.312024Z","caller":"traceutil/trace.go:171","msg":"trace[1260290434] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1708; }","duration":"126.033902ms","start":"2026-04-22T06:05:45.185975Z","end":"2026-04-22T06:05:45.312009Z","steps":["trace[1260290434] 'agreement among raft nodes before linearized reading'  (duration: 125.823388ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:51.663037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.121131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093070924 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1740 > 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-22T06:05:51.663261Z","caller":"traceutil/trace.go:171","msg":"trace[1755409796] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1877; }","duration":"203.286864ms","start":"2026-04-22T06:05:51.459952Z","end":"2026-04-22T06:05:51.663239Z","steps":["trace[1755409796] 'read index received'  (duration: 35.583161ms)","trace[1755409796] 'applied index is now lower than readState.Index'  (duration: 167.702363ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:51.66342Z","caller":"traceutil/trace.go:171","msg":"trace[770411960] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"230.376173ms","start":"2026-04-22T06:05:51.432976Z","end":"2026-04-22T06:05:51.663352Z","steps":["trace[770411960] 'process raft request'  (duration: 117.836244ms)","trace[770411960] 'compare'  (duration: 111.987259ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:51.663471Z","caller":"traceutil/trace.go:171","msg":"trace[476665915] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"176.036473ms","start":"2026-04-22T06:05:51.487391Z","end":"2026-04-22T06:05:51.663428Z","steps":["trace[476665915] 'process raft request'  (duration: 175.771388ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:51.663641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.695101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:10328"}
{"level":"info","ts":"2026-04-22T06:05:51.663738Z","caller":"traceutil/trace.go:171","msg":"trace[1083468698] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1808; }","duration":"203.782683ms","start":"2026-04-22T06:05:51.459895Z","end":"2026-04-22T06:05:51.663678Z","steps":["trace[1083468698] 'agreement among raft nodes before linearized reading'  (duration: 203.530138ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:51.854455Z","caller":"traceutil/trace.go:171","msg":"trace[250882715] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"180.804979ms","start":"2026-04-22T06:05:51.673618Z","end":"2026-04-22T06:05:51.854423Z","steps":["trace[250882715] 'process raft request'  (duration: 102.522398ms)","trace[250882715] 'compare'  (duration: 78.088828ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:52.033014Z","caller":"traceutil/trace.go:171","msg":"trace[1194822461] linearizableReadLoop","detail":"{readStateIndex:1882; appliedIndex:1881; }","duration":"170.333189ms","start":"2026-04-22T06:05:51.862652Z","end":"2026-04-22T06:05:52.032985Z","steps":["trace[1194822461] 'read index received'  (duration: 170.038944ms)","trace[1194822461] 'applied index is now lower than readState.Index'  (duration: 293.305µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:52.033132Z","caller":"traceutil/trace.go:171","msg":"trace[632915077] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"173.019008ms","start":"2026-04-22T06:05:51.860056Z","end":"2026-04-22T06:05:52.033075Z","steps":["trace[632915077] 'process raft request'  (duration: 172.717233ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:52.033253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.570854ms","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-22T06:05:52.03332Z","caller":"traceutil/trace.go:171","msg":"trace[450020523] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1810; }","duration":"170.713977ms","start":"2026-04-22T06:05:51.86259Z","end":"2026-04-22T06:05:52.033304Z","steps":["trace[450020523] 'agreement among raft nodes before linearized reading'  (duration: 170.581113ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:52.033647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.404937ms","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-22T06:05:52.033812Z","caller":"traceutil/trace.go:171","msg":"trace[904442011] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1810; }","duration":"117.676181ms","start":"2026-04-22T06:05:51.916096Z","end":"2026-04-22T06:05:52.033772Z","steps":["trace[904442011] 'agreement among raft nodes before linearized reading'  (duration: 117.185872ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:53.706924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.498471ms","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-22T06:05:53.707025Z","caller":"traceutil/trace.go:171","msg":"trace[650021466] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1822; }","duration":"202.637423ms","start":"2026-04-22T06:05:53.504357Z","end":"2026-04-22T06:05:53.706994Z","steps":["trace[650021466] 'range keys from in-memory index tree'  (duration: 202.345238ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:53.707338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.171601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-22T06:05:53.707511Z","caller":"traceutil/trace.go:171","msg":"trace[1889401837] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515; range_end:; response_count:1; response_revision:1822; }","duration":"199.919903ms","start":"2026-04-22T06:05:53.507556Z","end":"2026-04-22T06:05:53.707476Z","steps":["trace[1889401837] 'range keys from in-memory index tree'  (duration: 198.972856ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:53.811047Z","caller":"traceutil/trace.go:171","msg":"trace[1701816965] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1896; }","duration":"137.996516ms","start":"2026-04-22T06:05:53.673023Z","end":"2026-04-22T06:05:53.811019Z","steps":["trace[1701816965] 'read index received'  (duration: 137.822373ms)","trace[1701816965] 'applied index is now lower than readState.Index'  (duration: 172.753µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:53.811087Z","caller":"traceutil/trace.go:171","msg":"trace[1062319411] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"142.05588ms","start":"2026-04-22T06:05:53.669005Z","end":"2026-04-22T06:05:53.81106Z","steps":["trace[1062319411] 'process raft request'  (duration: 141.845887ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:53.811335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.293272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-22T06:05:53.81139Z","caller":"traceutil/trace.go:171","msg":"trace[180663603] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515; range_end:; response_count:1; response_revision:1823; }","duration":"138.431545ms","start":"2026-04-22T06:05:53.672946Z","end":"2026-04-22T06:05:53.811377Z","steps":["trace[180663603] 'agreement among raft nodes before linearized reading'  (duration: 138.1826ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:53.87479Z","caller":"traceutil/trace.go:171","msg":"trace[689228312] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"160.540524ms","start":"2026-04-22T06:05:53.714234Z","end":"2026-04-22T06:05:53.874775Z","steps":["trace[689228312] 'process raft request'  (duration: 160.421492ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:53.875047Z","caller":"traceutil/trace.go:171","msg":"trace[972120545] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"156.352779ms","start":"2026-04-22T06:05:53.718683Z","end":"2026-04-22T06:05:53.875036Z","steps":["trace[972120545] 'process raft request'  (duration: 156.268197ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:53.875083Z","caller":"traceutil/trace.go:171","msg":"trace[1510967513] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"160.168277ms","start":"2026-04-22T06:05:53.714857Z","end":"2026-04-22T06:05:53.875025Z","steps":["trace[1510967513] 'process raft request'  (duration: 159.883722ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.667205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.306925ms","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-22T06:05:54.667293Z","caller":"traceutil/trace.go:171","msg":"trace[932595826] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1826; }","duration":"618.447108ms","start":"2026-04-22T06:05:54.048823Z","end":"2026-04-22T06:05:54.66727Z","steps":["trace[932595826] 'range keys from in-memory index tree'  (duration: 618.112702ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.667452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:54.0488Z","time spent":"618.639121ms","remote":"127.0.0.1:55976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-04-22T06:05:54.713687Z","caller":"traceutil/trace.go:171","msg":"trace[1764467559] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"636.89024ms","start":"2026-04-22T06:05:54.076777Z","end":"2026-04-22T06:05:54.713668Z","steps":["trace[1764467559] 'process raft request'  (duration: 636.694527ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.713821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:54.076752Z","time spent":"636.993971ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1811 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-22T06:05:54.742756Z","caller":"traceutil/trace.go:171","msg":"trace[500343133] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1901; }","duration":"460.99513ms","start":"2026-04-22T06:05:54.281716Z","end":"2026-04-22T06:05:54.742711Z","steps":["trace[500343133] 'read index received'  (duration: 432.352093ms)","trace[500343133] 'applied index is now lower than readState.Index'  (duration: 28.642077ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:54.742876Z","caller":"traceutil/trace.go:171","msg":"trace[1781549942] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"573.514078ms","start":"2026-04-22T06:05:54.169265Z","end":"2026-04-22T06:05:54.742779Z","steps":["trace[1781549942] 'process raft request'  (duration: 573.279114ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.742977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:54.16925Z","time spent":"573.676311ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1701 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-04-22T06:05:54.742985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.248534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:05:54.74311Z","caller":"traceutil/trace.go:171","msg":"trace[1043776489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1828; }","duration":"461.421557ms","start":"2026-04-22T06:05:54.281647Z","end":"2026-04-22T06:05:54.743068Z","steps":["trace[1043776489] 'agreement among raft nodes before linearized reading'  (duration: 461.242544ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.743146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:54.281618Z","time spent":"461.518289ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T06:05:54.743231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.582429ms","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":"warn","ts":"2026-04-22T06:05:54.743253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.797134ms","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-22T06:05:54.74331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.135453ms","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-22T06:05:54.743325Z","caller":"traceutil/trace.go:171","msg":"trace[962508835] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1828; }","duration":"117.748623ms","start":"2026-04-22T06:05:54.625549Z","end":"2026-04-22T06:05:54.743297Z","steps":["trace[962508835] 'agreement among raft nodes before linearized reading'  (duration: 117.462098ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:54.743357Z","caller":"traceutil/trace.go:171","msg":"trace[1530694158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1828; }","duration":"188.942996ms","start":"2026-04-22T06:05:54.554391Z","end":"2026-04-22T06:05:54.743334Z","steps":["trace[1530694158] 'agreement among raft nodes before linearized reading'  (duration: 188.678951ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:54.743371Z","caller":"traceutil/trace.go:171","msg":"trace[956270241] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1828; }","duration":"354.212425ms","start":"2026-04-22T06:05:54.389135Z","end":"2026-04-22T06:05:54.743348Z","steps":["trace[956270241] 'agreement among raft nodes before linearized reading'  (duration: 354.043362ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.743424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:54.389111Z","time spent":"354.304896ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:05:54.743106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.003619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T06:05:54.743533Z","caller":"traceutil/trace.go:171","msg":"trace[1353709360] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1828; }","duration":"370.499608ms","start":"2026-04-22T06:05:54.373016Z","end":"2026-04-22T06:05:54.743516Z","steps":["trace[1353709360] 'agreement among raft nodes before linearized reading'  (duration: 369.951008ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:54.743589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:54.372978Z","time spent":"370.588959ms","remote":"127.0.0.1:53136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":56,"response size":29,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T06:05:55.020549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.140686ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093070984 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1813 > 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-22T06:05:55.020909Z","caller":"traceutil/trace.go:171","msg":"trace[2059528056] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"272.129095ms","start":"2026-04-22T06:05:54.748738Z","end":"2026-04-22T06:05:55.020867Z","steps":["trace[2059528056] 'process raft request'  (duration: 171.515931ms)","trace[2059528056] 'compare'  (duration: 99.737309ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:55.020987Z","caller":"traceutil/trace.go:171","msg":"trace[2024024562] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"272.191146ms","start":"2026-04-22T06:05:54.748767Z","end":"2026-04-22T06:05:55.020958Z","steps":["trace[2024024562] 'process raft request'  (duration: 271.932051ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:55.021477Z","caller":"traceutil/trace.go:171","msg":"trace[1672076778] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"272.572393ms","start":"2026-04-22T06:05:54.748883Z","end":"2026-04-22T06:05:55.021455Z","steps":["trace[1672076778] 'process raft request'  (duration: 271.925881ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:55.021497Z","caller":"traceutil/trace.go:171","msg":"trace[479293608] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1903; }","duration":"247.723295ms","start":"2026-04-22T06:05:54.773749Z","end":"2026-04-22T06:05:55.021472Z","steps":["trace[479293608] 'read index received'  (duration: 146.453339ms)","trace[479293608] 'applied index is now lower than readState.Index'  (duration: 101.268606ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:05:55.021721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.952579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T06:05:55.021813Z","caller":"traceutil/trace.go:171","msg":"trace[1973415445] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1833; }","duration":"248.080682ms","start":"2026-04-22T06:05:54.773719Z","end":"2026-04-22T06:05:55.021799Z","steps":["trace[1973415445] 'agreement among raft nodes before linearized reading'  (duration: 247.921299ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:55.021814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.83562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-04-22T06:05:55.021861Z","caller":"traceutil/trace.go:171","msg":"trace[2137067034] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515; range_end:; response_count:1; response_revision:1833; }","duration":"205.903381ms","start":"2026-04-22T06:05:54.815943Z","end":"2026-04-22T06:05:55.021846Z","steps":["trace[2137067034] 'agreement among raft nodes before linearized reading'  (duration: 205.727938ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:55.02164Z","caller":"traceutil/trace.go:171","msg":"trace[209145508] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"272.685185ms","start":"2026-04-22T06:05:54.74894Z","end":"2026-04-22T06:05:55.021626Z","steps":["trace[209145508] 'process raft request'  (duration: 272.167075ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:56.132405Z","caller":"traceutil/trace.go:171","msg":"trace[836845258] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"253.653882ms","start":"2026-04-22T06:05:55.87871Z","end":"2026-04-22T06:05:56.132363Z","steps":["trace[836845258] 'read index received'  (duration: 253.160413ms)","trace[836845258] 'applied index is now lower than readState.Index'  (duration: 491.879µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:05:56.132474Z","caller":"traceutil/trace.go:171","msg":"trace[992123178] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"316.335282ms","start":"2026-04-22T06:05:55.816106Z","end":"2026-04-22T06:05:56.132442Z","steps":["trace[992123178] 'process raft request'  (duration: 315.291313ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:56.132629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:55.816088Z","time spent":"316.461614ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1823 > 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-22T06:05:56.132794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.049199ms","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-22T06:05:56.132844Z","caller":"traceutil/trace.go:171","msg":"trace[199929547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1835; }","duration":"254.183941ms","start":"2026-04-22T06:05:55.878648Z","end":"2026-04-22T06:05:56.132832Z","steps":["trace[199929547] 'agreement among raft nodes before linearized reading'  (duration: 253.921946ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:56.132896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.407418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-04-22T06:05:56.13294Z","caller":"traceutil/trace.go:171","msg":"trace[765365] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-51cd8b94-e939-4d95-99ad-027f35fbb515; range_end:; response_count:1; response_revision:1835; }","duration":"106.46671ms","start":"2026-04-22T06:05:56.026456Z","end":"2026-04-22T06:05:56.132923Z","steps":["trace[765365] 'agreement among raft nodes before linearized reading'  (duration: 106.325787ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:05:56.133361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.977738ms","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-22T06:05:56.13346Z","caller":"traceutil/trace.go:171","msg":"trace[981212254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1835; }","duration":"254.462887ms","start":"2026-04-22T06:05:55.878976Z","end":"2026-04-22T06:05:56.133439Z","steps":["trace[981212254] 'agreement among raft nodes before linearized reading'  (duration: 253.808755ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:56.352719Z","caller":"traceutil/trace.go:171","msg":"trace[1319750394] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"215.424723ms","start":"2026-04-22T06:05:56.137276Z","end":"2026-04-22T06:05:56.352701Z","steps":["trace[1319750394] 'process raft request'  (duration: 215.099516ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:05:56.353184Z","caller":"traceutil/trace.go:171","msg":"trace[915327076] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"214.767522ms","start":"2026-04-22T06:05:56.138389Z","end":"2026-04-22T06:05:56.353157Z","steps":["trace[915327076] 'process raft request'  (duration: 214.605789ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:05.165313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.278157ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:06:05.165476Z","caller":"traceutil/trace.go:171","msg":"trace[683214834] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1922; }","duration":"192.46087ms","start":"2026-04-22T06:06:04.972993Z","end":"2026-04-22T06:06:05.165454Z","steps":["trace[683214834] 'range keys from in-memory index tree'  (duration: 192.254896ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:05.165717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.70691ms","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-22T06:06:05.165816Z","caller":"traceutil/trace.go:171","msg":"trace[933164801] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1922; }","duration":"427.853762ms","start":"2026-04-22T06:06:04.737936Z","end":"2026-04-22T06:06:05.16579Z","steps":["trace[933164801] 'range keys from in-memory index tree'  (duration: 427.521666ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:05.165848Z","caller":"traceutil/trace.go:171","msg":"trace[764677906] linearizableReadLoop","detail":"{readStateIndex:2000; appliedIndex:1999; }","duration":"350.962026ms","start":"2026-04-22T06:06:04.814873Z","end":"2026-04-22T06:06:05.165835Z","steps":["trace[764677906] 'read index received'  (duration: 345.889924ms)","trace[764677906] 'applied index is now lower than readState.Index'  (duration: 5.071072ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:06:05.165859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:04.737915Z","time spent":"427.935503ms","remote":"127.0.0.1:55976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-04-22T06:06:05.165942Z","caller":"traceutil/trace.go:171","msg":"trace[919512818] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"419.747706ms","start":"2026-04-22T06:06:04.746141Z","end":"2026-04-22T06:06:05.165889Z","steps":["trace[919512818] 'process raft request'  (duration: 414.600593ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:05.166063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.199101ms","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-22T06:06:05.166101Z","caller":"traceutil/trace.go:171","msg":"trace[1846192426] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1923; }","duration":"351.284922ms","start":"2026-04-22T06:06:04.814806Z","end":"2026-04-22T06:06:05.166091Z","steps":["trace[1846192426] 'agreement among raft nodes before linearized reading'  (duration: 351.109489ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:05.166093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:04.746111Z","time spent":"419.890559ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1908 > 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-22T06:06:05.166134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:04.814756Z","time spent":"351.371453ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-04-22T06:06:12.410809Z","caller":"traceutil/trace.go:171","msg":"trace[1594376502] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"195.192208ms","start":"2026-04-22T06:06:12.21557Z","end":"2026-04-22T06:06:12.410762Z","steps":["trace[1594376502] 'read index received'  (duration: 194.852842ms)","trace[1594376502] 'applied index is now lower than readState.Index'  (duration: 337.706µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:12.410839Z","caller":"traceutil/trace.go:171","msg":"trace[309032122] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"212.010372ms","start":"2026-04-22T06:06:12.198801Z","end":"2026-04-22T06:06:12.410811Z","steps":["trace[309032122] 'process raft request'  (duration: 211.688375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:12.411057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.461074ms","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-22T06:06:12.411511Z","caller":"traceutil/trace.go:171","msg":"trace[1384998685] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1971; }","duration":"195.934352ms","start":"2026-04-22T06:06:12.215533Z","end":"2026-04-22T06:06:12.411468Z","steps":["trace[1384998685] 'agreement among raft nodes before linearized reading'  (duration: 195.375183ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:17.353086Z","caller":"traceutil/trace.go:171","msg":"trace[217731415] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"141.49604ms","start":"2026-04-22T06:06:17.211542Z","end":"2026-04-22T06:06:17.353038Z","steps":["trace[217731415] 'process raft request'  (duration: 141.183645ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:17.353634Z","caller":"traceutil/trace.go:171","msg":"trace[1752786180] linearizableReadLoop","detail":"{readStateIndex:2083; appliedIndex:2082; }","duration":"127.866135ms","start":"2026-04-22T06:06:17.225692Z","end":"2026-04-22T06:06:17.353559Z","steps":["trace[1752786180] 'read index received'  (duration: 126.879787ms)","trace[1752786180] 'applied index is now lower than readState.Index'  (duration: 976.998µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:06:17.353861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.14844ms","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-22T06:06:17.353972Z","caller":"traceutil/trace.go:171","msg":"trace[818844496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2004; }","duration":"128.318383ms","start":"2026-04-22T06:06:17.225625Z","end":"2026-04-22T06:06:17.353943Z","steps":["trace[818844496] 'agreement among raft nodes before linearized reading'  (duration: 128.065739ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:17.354047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.596046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-04-22T06:06:17.354152Z","caller":"traceutil/trace.go:171","msg":"trace[1536043021] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2004; }","duration":"124.737638ms","start":"2026-04-22T06:06:17.229388Z","end":"2026-04-22T06:06:17.354126Z","steps":["trace[1536043021] 'agreement among raft nodes before linearized reading'  (duration: 124.479454ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:17.354356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.9392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-04-22T06:06:17.354359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.073073ms","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-22T06:06:17.354403Z","caller":"traceutil/trace.go:171","msg":"trace[1495106253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2004; }","duration":"126.047762ms","start":"2026-04-22T06:06:17.228344Z","end":"2026-04-22T06:06:17.354392Z","steps":["trace[1495106253] 'agreement among raft nodes before linearized reading'  (duration: 125.910439ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:17.354374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.708537ms","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":"info","ts":"2026-04-22T06:06:17.354499Z","caller":"traceutil/trace.go:171","msg":"trace[561012438] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2004; }","duration":"125.868919ms","start":"2026-04-22T06:06:17.228602Z","end":"2026-04-22T06:06:17.354471Z","steps":["trace[561012438] 'agreement among raft nodes before linearized reading'  (duration: 125.464682ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:17.354418Z","caller":"traceutil/trace.go:171","msg":"trace[276587348] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2004; }","duration":"126.188755ms","start":"2026-04-22T06:06:17.228215Z","end":"2026-04-22T06:06:17.354404Z","steps":["trace[276587348] 'agreement among raft nodes before linearized reading'  (duration: 125.613945ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:17.6095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.696974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093071377 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1987 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:06:17.609865Z","caller":"traceutil/trace.go:171","msg":"trace[384602771] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"250.699949ms","start":"2026-04-22T06:06:17.35914Z","end":"2026-04-22T06:06:17.60984Z","steps":["trace[384602771] 'process raft request'  (duration: 123.524286ms)","trace[384602771] 'compare'  (duration: 126.528571ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:17.609981Z","caller":"traceutil/trace.go:171","msg":"trace[606696874] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"250.739639ms","start":"2026-04-22T06:06:17.35919Z","end":"2026-04-22T06:06:17.60993Z","steps":["trace[606696874] 'process raft request'  (duration: 250.536446ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:17.610098Z","caller":"traceutil/trace.go:171","msg":"trace[91655301] linearizableReadLoop","detail":"{readStateIndex:2088; appliedIndex:2084; }","duration":"166.42502ms","start":"2026-04-22T06:06:17.443633Z","end":"2026-04-22T06:06:17.610058Z","steps":["trace[91655301] 'read index received'  (duration: 38.955352ms)","trace[91655301] 'applied index is now lower than readState.Index'  (duration: 127.467678ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:17.610043Z","caller":"traceutil/trace.go:171","msg":"trace[414063793] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"249.609659ms","start":"2026-04-22T06:06:17.360375Z","end":"2026-04-22T06:06:17.609985Z","steps":["trace[414063793] 'process raft request'  (duration: 249.393196ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:17.610311Z","caller":"traceutil/trace.go:171","msg":"trace[754993033] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"251.112597ms","start":"2026-04-22T06:06:17.359166Z","end":"2026-04-22T06:06:17.610279Z","steps":["trace[754993033] 'process raft request'  (duration: 250.480166ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:17.610443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.796977ms","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-22T06:06:17.610509Z","caller":"traceutil/trace.go:171","msg":"trace[2018677145] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2009; }","duration":"166.99473ms","start":"2026-04-22T06:06:17.443495Z","end":"2026-04-22T06:06:17.610489Z","steps":["trace[2018677145] 'agreement among raft nodes before linearized reading'  (duration: 166.703885ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:22.610911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.355655ms","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-22T06:06:22.611009Z","caller":"traceutil/trace.go:171","msg":"trace[183800839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2035; }","duration":"123.503637ms","start":"2026-04-22T06:06:22.487487Z","end":"2026-04-22T06:06:22.61099Z","steps":["trace[183800839] 'range keys from in-memory index tree'  (duration: 123.13978ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:22.61113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.443448ms","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-22T06:06:22.611257Z","caller":"traceutil/trace.go:171","msg":"trace[2138293400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2035; }","duration":"122.736183ms","start":"2026-04-22T06:06:22.4885Z","end":"2026-04-22T06:06:22.611236Z","steps":["trace[2138293400] 'range keys from in-memory index tree'  (duration: 122.193564ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:25.668572Z","caller":"traceutil/trace.go:171","msg":"trace[1083769751] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"123.72435ms","start":"2026-04-22T06:06:25.544821Z","end":"2026-04-22T06:06:25.668546Z","steps":["trace[1083769751] 'process raft request'  (duration: 120.843888ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:27.691925Z","caller":"traceutil/trace.go:171","msg":"trace[28561885] linearizableReadLoop","detail":"{readStateIndex:2141; appliedIndex:2140; }","duration":"178.573849ms","start":"2026-04-22T06:06:27.513326Z","end":"2026-04-22T06:06:27.6919Z","steps":["trace[28561885] 'read index received'  (duration: 178.13974ms)","trace[28561885] 'applied index is now lower than readState.Index'  (duration: 433.079µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:27.692028Z","caller":"traceutil/trace.go:171","msg":"trace[1857687430] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"264.000448ms","start":"2026-04-22T06:06:27.427994Z","end":"2026-04-22T06:06:27.691995Z","steps":["trace[1857687430] 'process raft request'  (duration: 263.758393ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:27.692084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.749832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:06:27.692121Z","caller":"traceutil/trace.go:171","msg":"trace[224024411] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2060; }","duration":"178.836713ms","start":"2026-04-22T06:06:27.513274Z","end":"2026-04-22T06:06:27.692111Z","steps":["trace[224024411] 'agreement among raft nodes before linearized reading'  (duration: 178.749302ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:27.874554Z","caller":"traceutil/trace.go:171","msg":"trace[463827297] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"135.792007ms","start":"2026-04-22T06:06:27.738738Z","end":"2026-04-22T06:06:27.87453Z","steps":["trace[463827297] 'process raft request'  (duration: 127.874364ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:27.882307Z","caller":"traceutil/trace.go:171","msg":"trace[496117357] linearizableReadLoop","detail":"{readStateIndex:2145; appliedIndex:2142; }","duration":"133.64752ms","start":"2026-04-22T06:06:27.748636Z","end":"2026-04-22T06:06:27.882284Z","steps":["trace[496117357] 'read index received'  (duration: 117.987477ms)","trace[496117357] 'applied index is now lower than readState.Index'  (duration: 15.659083ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:27.882421Z","caller":"traceutil/trace.go:171","msg":"trace[1203246303] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"143.380975ms","start":"2026-04-22T06:06:27.739028Z","end":"2026-04-22T06:06:27.882409Z","steps":["trace[1203246303] 'process raft request'  (duration: 143.217521ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:27.882373Z","caller":"traceutil/trace.go:171","msg":"trace[219783585] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"143.578909ms","start":"2026-04-22T06:06:27.738774Z","end":"2026-04-22T06:06:27.882353Z","steps":["trace[219783585] 'process raft request'  (duration: 143.339194ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:27.882609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.952105ms","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-22T06:06:27.882683Z","caller":"traceutil/trace.go:171","msg":"trace[137428263] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2064; }","duration":"134.042816ms","start":"2026-04-22T06:06:27.748619Z","end":"2026-04-22T06:06:27.882662Z","steps":["trace[137428263] 'agreement among raft nodes before linearized reading'  (duration: 133.879193ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:39.983248Z","caller":"traceutil/trace.go:171","msg":"trace[753730039] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"162.396827ms","start":"2026-04-22T06:06:39.820832Z","end":"2026-04-22T06:06:39.983228Z","steps":["trace[753730039] 'read index received'  (duration: 162.225844ms)","trace[753730039] 'applied index is now lower than readState.Index'  (duration: 170.263µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:39.98352Z","caller":"traceutil/trace.go:171","msg":"trace[2010404421] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"174.616177ms","start":"2026-04-22T06:06:39.80889Z","end":"2026-04-22T06:06:39.983507Z","steps":["trace[2010404421] 'process raft request'  (duration: 174.22293ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:39.983792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.945318ms","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-22T06:06:39.983834Z","caller":"traceutil/trace.go:171","msg":"trace[1629124686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2124; }","duration":"163.027869ms","start":"2026-04-22T06:06:39.820796Z","end":"2026-04-22T06:06:39.983824Z","steps":["trace[1629124686] 'agreement among raft nodes before linearized reading'  (duration: 162.904287ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:40.819755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.379005ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093071686 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2119 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:06:40.820061Z","caller":"traceutil/trace.go:171","msg":"trace[404576317] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"829.40518ms","start":"2026-04-22T06:06:39.99062Z","end":"2026-04-22T06:06:40.820025Z","steps":["trace[404576317] 'process raft request'  (duration: 199.631408ms)","trace[404576317] 'compare'  (duration: 628.850565ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:06:40.820267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:39.990613Z","time spent":"829.547632ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2119 > 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-22T06:06:40.820757Z","caller":"traceutil/trace.go:171","msg":"trace[1752861150] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"830.04425ms","start":"2026-04-22T06:06:39.990664Z","end":"2026-04-22T06:06:40.820708Z","steps":["trace[1752861150] 'process raft request'  (duration: 829.218556ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:40.820825Z","caller":"traceutil/trace.go:171","msg":"trace[1989653082] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"829.033183ms","start":"2026-04-22T06:06:39.99176Z","end":"2026-04-22T06:06:40.820793Z","steps":["trace[1989653082] 'process raft request'  (duration: 828.941671ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:40.820842Z","caller":"traceutil/trace.go:171","msg":"trace[1297789374] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2209; }","duration":"537.978457ms","start":"2026-04-22T06:06:40.282834Z","end":"2026-04-22T06:06:40.820813Z","steps":["trace[1297789374] 'read index received'  (duration: 82.102µs)","trace[1297789374] 'applied index is now lower than readState.Index'  (duration: 537.893625ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:40.820846Z","caller":"traceutil/trace.go:171","msg":"trace[1111148273] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"830.071031ms","start":"2026-04-22T06:06:39.990733Z","end":"2026-04-22T06:06:40.820804Z","steps":["trace[1111148273] 'process raft request'  (duration: 829.868428ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:40.820896Z","caller":"traceutil/trace.go:171","msg":"trace[731584336] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"257.405199ms","start":"2026-04-22T06:06:40.563461Z","end":"2026-04-22T06:06:40.820866Z","steps":["trace[731584336] 'process raft request'  (duration: 257.293767ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:40.820977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:39.991731Z","time spent":"829.169517ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2117 > 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-22T06:06:40.821032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:39.990682Z","time spent":"830.253105ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2116 > 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":"warn","ts":"2026-04-22T06:06:40.820909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:39.990658Z","time spent":"830.193123ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2118 > 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":"info","ts":"2026-04-22T06:06:40.821138Z","caller":"traceutil/trace.go:171","msg":"trace[771800918] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"255.517117ms","start":"2026-04-22T06:06:40.565603Z","end":"2026-04-22T06:06:40.82112Z","steps":["trace[771800918] 'process raft request'  (duration: 255.20219ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:40.821218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.351754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:06:40.821305Z","caller":"traceutil/trace.go:171","msg":"trace[843447281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2131; }","duration":"538.524367ms","start":"2026-04-22T06:06:40.282752Z","end":"2026-04-22T06:06:40.821277Z","steps":["trace[843447281] 'agreement among raft nodes before linearized reading'  (duration: 538.198402ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:40.821384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:40.282707Z","time spent":"538.66572ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T06:06:41.124194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.39526ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093071695 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2122 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:06:41.124393Z","caller":"traceutil/trace.go:171","msg":"trace[325955615] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2215; }","duration":"165.887459ms","start":"2026-04-22T06:06:40.958485Z","end":"2026-04-22T06:06:41.124372Z","steps":["trace[325955615] 'read index received'  (duration: 61.276884ms)","trace[325955615] 'applied index is now lower than readState.Index'  (duration: 104.609395ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:41.124473Z","caller":"traceutil/trace.go:171","msg":"trace[386353402] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"298.664373ms","start":"2026-04-22T06:06:40.825746Z","end":"2026-04-22T06:06:41.124411Z","steps":["trace[386353402] 'process raft request'  (duration: 298.568651ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:41.124548Z","caller":"traceutil/trace.go:171","msg":"trace[759480770] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"299.04195ms","start":"2026-04-22T06:06:40.825479Z","end":"2026-04-22T06:06:41.124521Z","steps":["trace[759480770] 'process raft request'  (duration: 97.211852ms)","trace[759480770] 'compare'  (duration: 201.240288ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:06:41.124609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.65165ms","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-22T06:06:41.124642Z","caller":"traceutil/trace.go:171","msg":"trace[239586571] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2133; }","duration":"132.717542ms","start":"2026-04-22T06:06:40.991912Z","end":"2026-04-22T06:06:41.124629Z","steps":["trace[239586571] 'agreement among raft nodes before linearized reading'  (duration: 132.574969ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:41.124742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.243677ms","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-22T06:06:41.124935Z","caller":"traceutil/trace.go:171","msg":"trace[348323376] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2133; }","duration":"166.407359ms","start":"2026-04-22T06:06:40.958417Z","end":"2026-04-22T06:06:41.124824Z","steps":["trace[348323376] 'agreement among raft nodes before linearized reading'  (duration: 166.032612ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:42.322647Z","caller":"traceutil/trace.go:171","msg":"trace[1934058401] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"306.793067ms","start":"2026-04-22T06:06:42.015831Z","end":"2026-04-22T06:06:42.322624Z","steps":["trace[1934058401] 'read index received'  (duration: 306.575033ms)","trace[1934058401] 'applied index is now lower than readState.Index'  (duration: 217.154µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:42.322709Z","caller":"traceutil/trace.go:171","msg":"trace[987951444] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"333.674043ms","start":"2026-04-22T06:06:41.988998Z","end":"2026-04-22T06:06:42.322672Z","steps":["trace[987951444] 'process raft request'  (duration: 333.47502ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:42.322836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:41.988977Z","time spent":"333.780535ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2124 > 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-22T06:06:42.322877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.058964ms","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":"warn","ts":"2026-04-22T06:06:42.322856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.013091ms","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-22T06:06:42.322915Z","caller":"traceutil/trace.go:171","msg":"trace[1657745547] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2135; }","duration":"191.124975ms","start":"2026-04-22T06:06:42.131776Z","end":"2026-04-22T06:06:42.322901Z","steps":["trace[1657745547] 'agreement among raft nodes before linearized reading'  (duration: 190.975623ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:42.322949Z","caller":"traceutil/trace.go:171","msg":"trace[30998173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"307.130893ms","start":"2026-04-22T06:06:42.015795Z","end":"2026-04-22T06:06:42.322926Z","steps":["trace[30998173] 'agreement among raft nodes before linearized reading'  (duration: 306.925559ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:42.323009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:42.015784Z","time spent":"307.213764ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-22T06:06:48.439117Z","caller":"traceutil/trace.go:171","msg":"trace[480966685] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"109.441369ms","start":"2026-04-22T06:06:48.329651Z","end":"2026-04-22T06:06:48.439092Z","steps":["trace[480966685] 'process raft request'  (duration: 109.295236ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:48.469671Z","caller":"traceutil/trace.go:171","msg":"trace[1393282554] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"128.434091ms","start":"2026-04-22T06:06:48.341211Z","end":"2026-04-22T06:06:48.469645Z","steps":["trace[1393282554] 'process raft request'  (duration: 128.230428ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.093296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.670518ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093071793 > lease_revoke:<id:7edf9db3c9a400ed>","response":"size:27"}
{"level":"info","ts":"2026-04-22T06:06:49.094009Z","caller":"traceutil/trace.go:171","msg":"trace[711805116] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"242.171079ms","start":"2026-04-22T06:06:48.851814Z","end":"2026-04-22T06:06:49.093985Z","steps":["trace[711805116] 'process raft request'  (duration: 242.013126ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:49.094247Z","caller":"traceutil/trace.go:171","msg":"trace[907551693] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2251; }","duration":"731.216461ms","start":"2026-04-22T06:06:48.362981Z","end":"2026-04-22T06:06:49.094197Z","steps":["trace[907551693] 'read index received'  (duration: 75.787ms)","trace[907551693] 'applied index is now lower than readState.Index'  (duration: 655.423031ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:06:49.09466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.66204ms","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-22T06:06:49.094761Z","caller":"traceutil/trace.go:171","msg":"trace[1174893681] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2169; }","duration":"731.808462ms","start":"2026-04-22T06:06:48.362928Z","end":"2026-04-22T06:06:49.094737Z","steps":["trace[1174893681] 'agreement among raft nodes before linearized reading'  (duration: 731.432676ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.094809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.362904Z","time spent":"731.890674ms","remote":"127.0.0.1:55976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-04-22T06:06:49.329922Z","caller":"traceutil/trace.go:171","msg":"trace[1039496180] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2255; }","duration":"235.563879ms","start":"2026-04-22T06:06:49.094329Z","end":"2026-04-22T06:06:49.329893Z","steps":["trace[1039496180] 'read index received'  (duration: 235.07104ms)","trace[1039496180] 'applied index is now lower than readState.Index'  (duration: 491.349µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:06:49.330205Z","caller":"traceutil/trace.go:171","msg":"trace[967771329] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"255.470789ms","start":"2026-04-22T06:06:49.0747Z","end":"2026-04-22T06:06:49.33017Z","steps":["trace[967771329] 'process raft request'  (duration: 254.747866ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.330344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.467736ms","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-22T06:06:49.330355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.127829ms","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-22T06:06:49.330363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.951064ms","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-22T06:06:49.330378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.36924ms","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-22T06:06:49.330441Z","caller":"traceutil/trace.go:171","msg":"trace[1218431799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2170; }","duration":"903.566478ms","start":"2026-04-22T06:06:48.426826Z","end":"2026-04-22T06:06:49.330393Z","steps":["trace[1218431799] 'agreement among raft nodes before linearized reading'  (duration: 903.310934ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:49.330485Z","caller":"traceutil/trace.go:171","msg":"trace[1368083881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2170; }","duration":"472.107996ms","start":"2026-04-22T06:06:48.858355Z","end":"2026-04-22T06:06:49.330463Z","steps":["trace[1368083881] 'agreement among raft nodes before linearized reading'  (duration: 471.848232ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:49.33049Z","caller":"traceutil/trace.go:171","msg":"trace[1794687606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2170; }","duration":"476.259902ms","start":"2026-04-22T06:06:48.854159Z","end":"2026-04-22T06:06:49.330419Z","steps":["trace[1794687606] 'agreement among raft nodes before linearized reading'  (duration: 475.959796ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.330495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.426817Z","time spent":"903.66727ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T06:06:49.330546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.858344Z","time spent":"472.187608ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-22T06:06:49.330549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.854135Z","time spent":"476.402124ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-22T06:06:49.330527Z","caller":"traceutil/trace.go:171","msg":"trace[914080924] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2170; }","duration":"473.501341ms","start":"2026-04-22T06:06:48.85697Z","end":"2026-04-22T06:06:49.330471Z","steps":["trace[914080924] 'agreement among raft nodes before linearized reading'  (duration: 473.120205ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.330666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.856963Z","time spent":"473.658294ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:06:49.330651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.853825ms","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":"warn","ts":"2026-04-22T06:06:49.330756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.709944ms","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-22T06:06:49.330794Z","caller":"traceutil/trace.go:171","msg":"trace[1656077756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2170; }","duration":"119.801726ms","start":"2026-04-22T06:06:49.210983Z","end":"2026-04-22T06:06:49.330785Z","steps":["trace[1656077756] 'agreement among raft nodes before linearized reading'  (duration: 119.698964ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.330804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.065872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-04-22T06:06:49.330811Z","caller":"traceutil/trace.go:171","msg":"trace[1666876476] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2170; }","duration":"908.069849ms","start":"2026-04-22T06:06:48.422715Z","end":"2026-04-22T06:06:49.330784Z","steps":["trace[1666876476] 'agreement among raft nodes before linearized reading'  (duration: 907.839645ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:06:49.330838Z","caller":"traceutil/trace.go:171","msg":"trace[279038575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2170; }","duration":"114.120063ms","start":"2026-04-22T06:06:49.216707Z","end":"2026-04-22T06:06:49.330827Z","steps":["trace[279038575] 'agreement among raft nodes before linearized reading'  (duration: 114.027631ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.330862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.422687Z","time spent":"908.1618ms","remote":"127.0.0.1:55910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T06:06:49.331039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.186081ms","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-22T06:06:49.331147Z","caller":"traceutil/trace.go:171","msg":"trace[1365844235] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2170; }","duration":"476.333964ms","start":"2026-04-22T06:06:48.854796Z","end":"2026-04-22T06:06:49.33113Z","steps":["trace[1365844235] 'agreement among raft nodes before linearized reading'  (duration: 475.337636ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:06:49.331198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:48.854775Z","time spent":"476.411055ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:07:18.771856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.771678ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093072212 > lease_revoke:<id:7edf9db3c9a4027f>","response":"size:27"}
{"level":"info","ts":"2026-04-22T06:07:19.637118Z","caller":"traceutil/trace.go:171","msg":"trace[531258103] transaction","detail":"{read_only:false; response_revision:2341; number_of_response:1; }","duration":"137.1875ms","start":"2026-04-22T06:07:19.499902Z","end":"2026-04-22T06:07:19.63709Z","steps":["trace[531258103] 'process raft request'  (duration: 136.278993ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:19.637627Z","caller":"traceutil/trace.go:171","msg":"trace[1991083654] transaction","detail":"{read_only:false; response_revision:2342; number_of_response:1; }","duration":"137.360044ms","start":"2026-04-22T06:07:19.500163Z","end":"2026-04-22T06:07:19.637523Z","steps":["trace[1991083654] 'process raft request'  (duration: 136.878605ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:19.637752Z","caller":"traceutil/trace.go:171","msg":"trace[1457377981] transaction","detail":"{read_only:false; response_revision:2343; number_of_response:1; }","duration":"137.399874ms","start":"2026-04-22T06:07:19.500304Z","end":"2026-04-22T06:07:19.637704Z","steps":["trace[1457377981] 'process raft request'  (duration: 137.069958ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:19.637811Z","caller":"traceutil/trace.go:171","msg":"trace[1861569232] transaction","detail":"{read_only:false; response_revision:2344; number_of_response:1; }","duration":"136.699151ms","start":"2026-04-22T06:07:19.501093Z","end":"2026-04-22T06:07:19.637793Z","steps":["trace[1861569232] 'process raft request'  (duration: 136.403416ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:19.637631Z","caller":"traceutil/trace.go:171","msg":"trace[1010516204] linearizableReadLoop","detail":"{readStateIndex:2437; appliedIndex:2432; }","duration":"134.811597ms","start":"2026-04-22T06:07:19.502749Z","end":"2026-04-22T06:07:19.63756Z","steps":["trace[1010516204] 'read index received'  (duration: 11.214063ms)","trace[1010516204] 'applied index is now lower than readState.Index'  (duration: 123.596294ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:07:19.637881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.095112ms","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-22T06:07:19.637943Z","caller":"traceutil/trace.go:171","msg":"trace[1974637254] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2344; }","duration":"135.208594ms","start":"2026-04-22T06:07:19.50272Z","end":"2026-04-22T06:07:19.637929Z","steps":["trace[1974637254] 'agreement among raft nodes before linearized reading'  (duration: 134.98702ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:19.638238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.333707ms","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-22T06:07:19.638315Z","caller":"traceutil/trace.go:171","msg":"trace[882781301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2344; }","duration":"135.47618ms","start":"2026-04-22T06:07:19.502818Z","end":"2026-04-22T06:07:19.638294Z","steps":["trace[882781301] 'agreement among raft nodes before linearized reading'  (duration: 135.174204ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.179129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142199164093072439,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-22T06:07:30.343174Z","caller":"traceutil/trace.go:171","msg":"trace[526705379] linearizableReadLoop","detail":"{readStateIndex:2530; appliedIndex:2529; }","duration":"665.103255ms","start":"2026-04-22T06:07:29.678046Z","end":"2026-04-22T06:07:30.34315Z","steps":["trace[526705379] 'read index received'  (duration: 665.001014ms)","trace[526705379] 'applied index is now lower than readState.Index'  (duration: 100.941µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:07:30.3433Z","caller":"traceutil/trace.go:171","msg":"trace[2074708769] transaction","detail":"{read_only:false; response_revision:2435; number_of_response:1; }","duration":"740.666982ms","start":"2026-04-22T06:07:29.602622Z","end":"2026-04-22T06:07:30.343289Z","steps":["trace[2074708769] 'process raft request'  (duration: 740.376577ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.343406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.602598Z","time spent":"740.728133ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2394 > 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-22T06:07:30.343533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.086346ms","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-22T06:07:30.3436Z","caller":"traceutil/trace.go:171","msg":"trace[1459865389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2435; }","duration":"617.20276ms","start":"2026-04-22T06:07:29.726378Z","end":"2026-04-22T06:07:30.343581Z","steps":["trace[1459865389] 'agreement among raft nodes before linearized reading'  (duration: 616.989235ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.343608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.405101ms","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-22T06:07:30.343649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.191722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"}
{"level":"info","ts":"2026-04-22T06:07:30.343708Z","caller":"traceutil/trace.go:171","msg":"trace[413562563] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2435; }","duration":"582.533613ms","start":"2026-04-22T06:07:29.761147Z","end":"2026-04-22T06:07:30.343681Z","steps":["trace[413562563] 'agreement among raft nodes before linearized reading'  (duration: 582.249027ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.343751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.647147ms","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-22T06:07:30.343756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.761138Z","time spent":"582.609204ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-22T06:07:30.343769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.625627ms","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-22T06:07:30.343644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.726361Z","time spent":"617.273971ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-22T06:07:30.343795Z","caller":"traceutil/trace.go:171","msg":"trace[350939020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2435; }","duration":"586.721768ms","start":"2026-04-22T06:07:29.757061Z","end":"2026-04-22T06:07:30.343782Z","steps":["trace[350939020] 'agreement among raft nodes before linearized reading'  (duration: 586.608076ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:30.343811Z","caller":"traceutil/trace.go:171","msg":"trace[1241593775] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2435; }","duration":"586.678028ms","start":"2026-04-22T06:07:29.75712Z","end":"2026-04-22T06:07:30.343798Z","steps":["trace[1241593775] 'agreement among raft nodes before linearized reading'  (duration: 586.545785ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.34379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.714407ms","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-22T06:07:30.343845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.757115Z","time spent":"586.723438ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:07:30.343841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.757043Z","time spent":"586.788079ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-22T06:07:30.343877Z","caller":"traceutil/trace.go:171","msg":"trace[1589894396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2435; }","duration":"665.86806ms","start":"2026-04-22T06:07:29.677989Z","end":"2026-04-22T06:07:30.343857Z","steps":["trace[1589894396] 'agreement among raft nodes before linearized reading'  (duration: 665.582395ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.343871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.691667ms","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-22T06:07:30.343922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.677962Z","time spent":"665.952361ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-22T06:07:30.343931Z","caller":"traceutil/trace.go:171","msg":"trace[2112472095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2435; }","duration":"586.76896ms","start":"2026-04-22T06:07:29.757147Z","end":"2026-04-22T06:07:30.343916Z","steps":["trace[2112472095] 'agreement among raft nodes before linearized reading'  (duration: 586.593207ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:30.343731Z","caller":"traceutil/trace.go:171","msg":"trace[133776283] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2435; }","duration":"298.315684ms","start":"2026-04-22T06:07:30.045392Z","end":"2026-04-22T06:07:30.343708Z","steps":["trace[133776283] 'agreement among raft nodes before linearized reading'  (duration: 298.079309ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:30.343964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:29.75714Z","time spent":"586.8169ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-22T06:07:36.905026Z","caller":"traceutil/trace.go:171","msg":"trace[1953720896] linearizableReadLoop","detail":"{readStateIndex:2580; appliedIndex:2579; }","duration":"151.757584ms","start":"2026-04-22T06:07:36.753242Z","end":"2026-04-22T06:07:36.905Z","steps":["trace[1953720896] 'read index received'  (duration: 151.600921ms)","trace[1953720896] 'applied index is now lower than readState.Index'  (duration: 155.073µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:07:36.905098Z","caller":"traceutil/trace.go:171","msg":"trace[239246133] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"169.451143ms","start":"2026-04-22T06:07:36.735615Z","end":"2026-04-22T06:07:36.905066Z","steps":["trace[239246133] 'process raft request'  (duration: 169.210849ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:36.905152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.893457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:07:36.90519Z","caller":"traceutil/trace.go:171","msg":"trace[1785997219] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2484; }","duration":"151.978048ms","start":"2026-04-22T06:07:36.753202Z","end":"2026-04-22T06:07:36.90518Z","steps":["trace[1785997219] 'agreement among raft nodes before linearized reading'  (duration: 151.895387ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.569899Z","caller":"traceutil/trace.go:171","msg":"trace[1738079362] linearizableReadLoop","detail":"{readStateIndex:2583; appliedIndex:2582; }","duration":"152.421147ms","start":"2026-04-22T06:07:38.417447Z","end":"2026-04-22T06:07:38.569869Z","steps":["trace[1738079362] 'read index received'  (duration: 152.118231ms)","trace[1738079362] 'applied index is now lower than readState.Index'  (duration: 301.576µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:07:38.570059Z","caller":"traceutil/trace.go:171","msg":"trace[1728337075] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"164.665808ms","start":"2026-04-22T06:07:38.405323Z","end":"2026-04-22T06:07:38.569988Z","steps":["trace[1728337075] 'process raft request'  (duration: 164.347482ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:38.57023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.479003ms","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-22T06:07:38.570278Z","caller":"traceutil/trace.go:171","msg":"trace[1633750437] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2487; }","duration":"149.578175ms","start":"2026-04-22T06:07:38.420685Z","end":"2026-04-22T06:07:38.570263Z","steps":["trace[1633750437] 'agreement among raft nodes before linearized reading'  (duration: 149.397642ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:38.57041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.34458ms","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-22T06:07:38.570543Z","caller":"traceutil/trace.go:171","msg":"trace[1447047456] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2487; }","duration":"144.536423ms","start":"2026-04-22T06:07:38.425983Z","end":"2026-04-22T06:07:38.570519Z","steps":["trace[1447047456] 'agreement among raft nodes before linearized reading'  (duration: 144.149666ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:38.570477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.021827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-04-22T06:07:38.57065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.305841ms","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-22T06:07:38.57073Z","caller":"traceutil/trace.go:171","msg":"trace[943122554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2487; }","duration":"148.442774ms","start":"2026-04-22T06:07:38.422267Z","end":"2026-04-22T06:07:38.570709Z","steps":["trace[943122554] 'agreement among raft nodes before linearized reading'  (duration: 148.017707ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:38.57078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.509065ms","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-22T06:07:38.570781Z","caller":"traceutil/trace.go:171","msg":"trace[1740645405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2487; }","duration":"153.309582ms","start":"2026-04-22T06:07:38.417385Z","end":"2026-04-22T06:07:38.570695Z","steps":["trace[1740645405] 'agreement among raft nodes before linearized reading'  (duration: 152.62878ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.570906Z","caller":"traceutil/trace.go:171","msg":"trace[1697409741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2487; }","duration":"148.698929ms","start":"2026-04-22T06:07:38.422186Z","end":"2026-04-22T06:07:38.570885Z","steps":["trace[1697409741] 'agreement among raft nodes before linearized reading'  (duration: 148.24192ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:07:38.571301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.347197ms","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-22T06:07:38.571378Z","caller":"traceutil/trace.go:171","msg":"trace[1705261609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2487; }","duration":"146.442748ms","start":"2026-04-22T06:07:38.424914Z","end":"2026-04-22T06:07:38.571357Z","steps":["trace[1705261609] 'agreement among raft nodes before linearized reading'  (duration: 145.42227ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.713198Z","caller":"traceutil/trace.go:171","msg":"trace[85959275] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"136.682981ms","start":"2026-04-22T06:07:38.576493Z","end":"2026-04-22T06:07:38.713176Z","steps":["trace[85959275] 'process raft request'  (duration: 136.522828ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.713539Z","caller":"traceutil/trace.go:171","msg":"trace[1033403939] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"136.526878ms","start":"2026-04-22T06:07:38.576978Z","end":"2026-04-22T06:07:38.713505Z","steps":["trace[1033403939] 'process raft request'  (duration: 136.129471ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.713685Z","caller":"traceutil/trace.go:171","msg":"trace[478210066] transaction","detail":"{read_only:false; response_revision:2492; number_of_response:1; }","duration":"136.58261ms","start":"2026-04-22T06:07:38.57709Z","end":"2026-04-22T06:07:38.713673Z","steps":["trace[478210066] 'process raft request'  (duration: 136.367185ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.713561Z","caller":"traceutil/trace.go:171","msg":"trace[1050916101] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"136.342475ms","start":"2026-04-22T06:07:38.577198Z","end":"2026-04-22T06:07:38.71354Z","steps":["trace[1050916101] 'process raft request'  (duration: 136.295984ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:07:38.713649Z","caller":"traceutil/trace.go:171","msg":"trace[770155283] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"136.57547ms","start":"2026-04-22T06:07:38.577064Z","end":"2026-04-22T06:07:38.713639Z","steps":["trace[770155283] 'process raft request'  (duration: 136.291834ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:01.612779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.093359ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093072932 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2596 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:08:01.612988Z","caller":"traceutil/trace.go:171","msg":"trace[1924605099] transaction","detail":"{read_only:false; response_revision:2607; number_of_response:1; }","duration":"766.125585ms","start":"2026-04-22T06:08:00.846827Z","end":"2026-04-22T06:08:01.612953Z","steps":["trace[1924605099] 'process raft request'  (duration: 592.77051ms)","trace[1924605099] 'compare'  (duration: 172.826964ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:08:01.613033Z","caller":"traceutil/trace.go:171","msg":"trace[916746904] transaction","detail":"{read_only:false; response_revision:2609; number_of_response:1; }","duration":"765.998052ms","start":"2026-04-22T06:08:00.847017Z","end":"2026-04-22T06:08:01.613015Z","steps":["trace[916746904] 'process raft request'  (duration: 765.928981ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:01.613099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:00.847007Z","time spent":"766.059953ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2597 > 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-22T06:08:01.613136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:00.846803Z","time spent":"766.253177ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2596 > 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-22T06:08:01.613262Z","caller":"traceutil/trace.go:171","msg":"trace[1296411805] transaction","detail":"{read_only:false; response_revision:2608; number_of_response:1; }","duration":"766.329508ms","start":"2026-04-22T06:08:00.846895Z","end":"2026-04-22T06:08:01.613224Z","steps":["trace[1296411805] 'process raft request'  (duration: 765.989322ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:01.613366Z","caller":"traceutil/trace.go:171","msg":"trace[1395749702] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"766.245936ms","start":"2026-04-22T06:08:00.847108Z","end":"2026-04-22T06:08:01.613354Z","steps":["trace[1395749702] 'process raft request'  (duration: 765.869859ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:01.613365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:00.846874Z","time spent":"766.441949ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2595 > 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-22T06:08:01.613394Z","caller":"traceutil/trace.go:171","msg":"trace[1101605763] linearizableReadLoop","detail":"{readStateIndex:2713; appliedIndex:2708; }","duration":"510.359615ms","start":"2026-04-22T06:08:01.103006Z","end":"2026-04-22T06:08:01.613366Z","steps":["trace[1101605763] 'read index received'  (duration: 336.605723ms)","trace[1101605763] 'applied index is now lower than readState.Index'  (duration: 173.752802ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:08:01.613434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:00.847088Z","time spent":"766.309807ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2598 > 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-22T06:08:01.613562Z","caller":"traceutil/trace.go:171","msg":"trace[1381143494] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"201.407584ms","start":"2026-04-22T06:08:01.412144Z","end":"2026-04-22T06:08:01.613552Z","steps":["trace[1381143494] 'process raft request'  (duration: 201.18797ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:01.613631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.444244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:08:01.613526Z","caller":"traceutil/trace.go:171","msg":"trace[293580430] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"626.38708ms","start":"2026-04-22T06:08:00.987129Z","end":"2026-04-22T06:08:01.613516Z","steps":["trace[293580430] 'process raft request'  (duration: 626.102685ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:01.613669Z","caller":"traceutil/trace.go:171","msg":"trace[1997305337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2612; }","duration":"333.565206ms","start":"2026-04-22T06:08:01.280094Z","end":"2026-04-22T06:08:01.613659Z","steps":["trace[1997305337] 'agreement among raft nodes before linearized reading'  (duration: 333.455554ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:01.613675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.666092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T06:08:01.613698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:01.280025Z","time spent":"333.666648ms","remote":"127.0.0.1:52956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-22T06:08:01.613712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:00.987111Z","time spent":"626.571483ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2599 > 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-22T06:08:01.613721Z","caller":"traceutil/trace.go:171","msg":"trace[1988494436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2612; }","duration":"510.740652ms","start":"2026-04-22T06:08:01.102968Z","end":"2026-04-22T06:08:01.613709Z","steps":["trace[1988494436] 'agreement among raft nodes before linearized reading'  (duration: 510.669851ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:01.613754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:01.102954Z","time spent":"510.793373ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-22T06:08:03.831452Z","caller":"traceutil/trace.go:171","msg":"trace[420453968] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"127.269963ms","start":"2026-04-22T06:08:03.704159Z","end":"2026-04-22T06:08:03.831429Z","steps":["trace[420453968] 'process raft request'  (duration: 127.231482ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:03.831494Z","caller":"traceutil/trace.go:171","msg":"trace[1678831013] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"127.68186ms","start":"2026-04-22T06:08:03.703764Z","end":"2026-04-22T06:08:03.831446Z","steps":["trace[1678831013] 'process raft request'  (duration: 123.228568ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:03.831598Z","caller":"traceutil/trace.go:171","msg":"trace[1182204613] transaction","detail":"{read_only:false; response_revision:2624; number_of_response:1; }","duration":"127.585998ms","start":"2026-04-22T06:08:03.704003Z","end":"2026-04-22T06:08:03.831589Z","steps":["trace[1182204613] 'process raft request'  (duration: 127.349404ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:07.001879Z","caller":"traceutil/trace.go:171","msg":"trace[1734334530] linearizableReadLoop","detail":"{readStateIndex:2738; appliedIndex:2737; }","duration":"123.136286ms","start":"2026-04-22T06:08:06.878721Z","end":"2026-04-22T06:08:07.001858Z","steps":["trace[1734334530] 'read index received'  (duration: 122.959072ms)","trace[1734334530] 'applied index is now lower than readState.Index'  (duration: 175.954µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:08:07.001956Z","caller":"traceutil/trace.go:171","msg":"trace[520166919] transaction","detail":"{read_only:false; response_revision:2635; number_of_response:1; }","duration":"273.337174ms","start":"2026-04-22T06:08:06.728576Z","end":"2026-04-22T06:08:07.001913Z","steps":["trace[520166919] 'process raft request'  (duration: 273.12589ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:07.002091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.35628ms","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-22T06:08:07.002127Z","caller":"traceutil/trace.go:171","msg":"trace[1646437407] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2635; }","duration":"123.459462ms","start":"2026-04-22T06:08:06.878658Z","end":"2026-04-22T06:08:07.002118Z","steps":["trace[1646437407] 'agreement among raft nodes before linearized reading'  (duration: 123.314809ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:07.506256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142199164093073020,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-22T06:08:07.83278Z","caller":"traceutil/trace.go:171","msg":"trace[1851784589] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"827.190993ms","start":"2026-04-22T06:08:07.005565Z","end":"2026-04-22T06:08:07.832756Z","steps":["trace[1851784589] 'process raft request'  (duration: 827.044101ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:07.832933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:07.005553Z","time spent":"827.299155ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2627 > 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":"info","ts":"2026-04-22T06:08:07.843461Z","caller":"traceutil/trace.go:171","msg":"trace[174931397] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"131.016192ms","start":"2026-04-22T06:08:07.712428Z","end":"2026-04-22T06:08:07.843444Z","steps":["trace[174931397] 'process raft request'  (duration: 130.947171ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:07.843658Z","caller":"traceutil/trace.go:171","msg":"trace[680453308] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"130.895251ms","start":"2026-04-22T06:08:07.71275Z","end":"2026-04-22T06:08:07.843645Z","steps":["trace[680453308] 'process raft request'  (duration: 130.663707ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:07.843667Z","caller":"traceutil/trace.go:171","msg":"trace[976757465] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"837.702958ms","start":"2026-04-22T06:08:07.005954Z","end":"2026-04-22T06:08:07.843657Z","steps":["trace[976757465] 'process raft request'  (duration: 837.31049ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:07.84379Z","caller":"traceutil/trace.go:171","msg":"trace[1027747991] linearizableReadLoop","detail":"{readStateIndex:2740; appliedIndex:2738; }","duration":"837.633716ms","start":"2026-04-22T06:08:07.006143Z","end":"2026-04-22T06:08:07.843776Z","steps":["trace[1027747991] 'read index received'  (duration: 826.528061ms)","trace[1027747991] 'applied index is now lower than readState.Index'  (duration: 11.104365ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:08:07.843892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:07.005935Z","time spent":"837.83262ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2628 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-22T06:08:07.843991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.84036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:8742"}
{"level":"info","ts":"2026-04-22T06:08:07.844035Z","caller":"traceutil/trace.go:171","msg":"trace[63253872] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2640; }","duration":"837.90367ms","start":"2026-04-22T06:08:07.006117Z","end":"2026-04-22T06:08:07.844021Z","steps":["trace[63253872] 'agreement among raft nodes before linearized reading'  (duration: 837.747328ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:07.844081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:07.006112Z","time spent":"837.956321ms","remote":"127.0.0.1:53120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":8764,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-04-22T06:08:07.844287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.580652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:08:07.844553Z","caller":"traceutil/trace.go:171","msg":"trace[633617333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2640; }","duration":"562.909067ms","start":"2026-04-22T06:08:07.281614Z","end":"2026-04-22T06:08:07.844523Z","steps":["trace[633617333] 'agreement among raft nodes before linearized reading'  (duration: 562.576681ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:07.844725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:07.281563Z","time spent":"563.145023ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-22T06:08:38.54282Z","caller":"traceutil/trace.go:171","msg":"trace[227209379] transaction","detail":"{read_only:false; response_revision:2802; number_of_response:1; }","duration":"192.294356ms","start":"2026-04-22T06:08:38.350508Z","end":"2026-04-22T06:08:38.542802Z","steps":["trace[227209379] 'process raft request'  (duration: 192.03001ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:08:38.543092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.425383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-04-22T06:08:38.543176Z","caller":"traceutil/trace.go:171","msg":"trace[43405304] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2802; }","duration":"109.544774ms","start":"2026-04-22T06:08:38.433611Z","end":"2026-04-22T06:08:38.543156Z","steps":["trace[43405304] 'agreement among raft nodes before linearized reading'  (duration: 109.29054ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:08:38.543249Z","caller":"traceutil/trace.go:171","msg":"trace[1811918236] linearizableReadLoop","detail":"{readStateIndex:2912; appliedIndex:2911; }","duration":"109.098877ms","start":"2026-04-22T06:08:38.433643Z","end":"2026-04-22T06:08:38.542741Z","steps":["trace[1811918236] 'read index received'  (duration: 108.858942ms)","trace[1811918236] 'applied index is now lower than readState.Index'  (duration: 238.585µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:06.29441Z","caller":"traceutil/trace.go:171","msg":"trace[784008648] linearizableReadLoop","detail":"{readStateIndex:4794; appliedIndex:4793; }","duration":"115.660417ms","start":"2026-04-22T06:12:06.178719Z","end":"2026-04-22T06:12:06.294379Z","steps":["trace[784008648] 'read index received'  (duration: 115.417841ms)","trace[784008648] 'applied index is now lower than readState.Index'  (duration: 241.216µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:06.295352Z","caller":"traceutil/trace.go:171","msg":"trace[1249828114] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"124.928609ms","start":"2026-04-22T06:12:06.170392Z","end":"2026-04-22T06:12:06.295321Z","steps":["trace[1249828114] 'process raft request'  (duration: 123.826978ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:06.29562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.867128ms","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-22T06:12:06.295671Z","caller":"traceutil/trace.go:171","msg":"trace[1925537802] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4613; }","duration":"116.986581ms","start":"2026-04-22T06:12:06.17867Z","end":"2026-04-22T06:12:06.295656Z","steps":["trace[1925537802] 'agreement among raft nodes before linearized reading'  (duration: 116.874949ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:11.598303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.160225ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093078467 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" mod_revision:4553 > success:<request_put:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" value_size:11357 >> failure:<request_range:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:12:11.599521Z","caller":"traceutil/trace.go:171","msg":"trace[1586718569] linearizableReadLoop","detail":"{readStateIndex:4998; appliedIndex:4997; }","duration":"318.05032ms","start":"2026-04-22T06:12:11.281446Z","end":"2026-04-22T06:12:11.599496Z","steps":["trace[1586718569] 'read index received'  (duration: 198.691024ms)","trace[1586718569] 'applied index is now lower than readState.Index'  (duration: 119.357016ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:11.599615Z","caller":"traceutil/trace.go:171","msg":"trace[1214844643] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"350.725289ms","start":"2026-04-22T06:12:11.248876Z","end":"2026-04-22T06:12:11.599601Z","steps":["trace[1214844643] 'process raft request'  (duration: 231.296182ms)","trace[1214844643] 'compare'  (duration: 116.957351ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:12:11.599691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:12:11.248844Z","time spent":"350.802941ms","remote":"127.0.0.1:53124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11440,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" mod_revision:4553 > success:<request_put:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" value_size:11357 >> failure:<request_range:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" > >"}
{"level":"warn","ts":"2026-04-22T06:12:11.599976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.489739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:12:11.600081Z","caller":"traceutil/trace.go:171","msg":"trace[684913518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4810; }","duration":"318.665781ms","start":"2026-04-22T06:12:11.281392Z","end":"2026-04-22T06:12:11.600058Z","steps":["trace[684913518] 'agreement among raft nodes before linearized reading'  (duration: 318.454797ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:11.600146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:12:11.281369Z","time spent":"318.767313ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-22T06:12:11.688031Z","caller":"traceutil/trace.go:171","msg":"trace[1554713200] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"365.540394ms","start":"2026-04-22T06:12:11.322439Z","end":"2026-04-22T06:12:11.687979Z","steps":["trace[1554713200] 'process raft request'  (duration: 365.30021ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:11.688199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.840827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1059a676-5a70-42c5-83f5-541191ae4d37\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-04-22T06:12:11.688232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:12:11.322418Z","time spent":"365.715918ms","remote":"127.0.0.1:53188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" value_size:3648 >> failure:<>"}
{"level":"info","ts":"2026-04-22T06:12:11.688287Z","caller":"traceutil/trace.go:171","msg":"trace[1157600662] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1059a676-5a70-42c5-83f5-541191ae4d37; range_end:; response_count:1; response_revision:4812; }","duration":"287.938138ms","start":"2026-04-22T06:12:11.400324Z","end":"2026-04-22T06:12:11.688263Z","steps":["trace[1157600662] 'agreement among raft nodes before linearized reading'  (duration: 287.679374ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:11.688291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.155488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-zdhrq.18a8990be4ed97ca\" ","response":"range_response_count:1 size:962"}
{"level":"info","ts":"2026-04-22T06:12:11.6884Z","caller":"traceutil/trace.go:171","msg":"trace[2118140817] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-zdhrq.18a8990be4ed97ca; range_end:; response_count:1; response_revision:4812; }","duration":"283.297331ms","start":"2026-04-22T06:12:11.405075Z","end":"2026-04-22T06:12:11.688372Z","steps":["trace[2118140817] 'agreement among raft nodes before linearized reading'  (duration: 282.926535ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:11.688417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.773044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:12:11.688414Z","caller":"traceutil/trace.go:171","msg":"trace[674016250] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"293.94041ms","start":"2026-04-22T06:12:11.394419Z","end":"2026-04-22T06:12:11.68836Z","steps":["trace[674016250] 'process raft request'  (duration: 293.464122ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:11.688501Z","caller":"traceutil/trace.go:171","msg":"trace[96298912] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:4812; }","duration":"384.916816ms","start":"2026-04-22T06:12:11.303566Z","end":"2026-04-22T06:12:11.688483Z","steps":["trace[96298912] 'agreement among raft nodes before linearized reading'  (duration: 384.764454ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:11.688536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:12:11.303541Z","time spent":"384.988537ms","remote":"127.0.0.1:53166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T06:12:30.85232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.554501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ba54d64-fa24-49ec-a932-ad3464f29b7e\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-04-22T06:12:30.852449Z","caller":"traceutil/trace.go:171","msg":"trace[2115230176] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ba54d64-fa24-49ec-a932-ad3464f29b7e; range_end:; response_count:1; response_revision:5211; }","duration":"235.751345ms","start":"2026-04-22T06:12:30.616676Z","end":"2026-04-22T06:12:30.852427Z","steps":["trace[2115230176] 'range keys from in-memory index tree'  (duration: 235.208275ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:30.852802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.628151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ba54d64-fa24-49ec-a932-ad3464f29b7e\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-04-22T06:12:30.852923Z","caller":"traceutil/trace.go:171","msg":"trace[780202382] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ba54d64-fa24-49ec-a932-ad3464f29b7e; range_end:; response_count:1; response_revision:5211; }","duration":"215.09284ms","start":"2026-04-22T06:12:30.637806Z","end":"2026-04-22T06:12:30.852899Z","steps":["trace[780202382] 'range keys from in-memory index tree'  (duration: 214.412657ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:30.853817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.842837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-04-22T06:12:30.853945Z","caller":"traceutil/trace.go:171","msg":"trace[139966992] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5211; }","duration":"162.0345ms","start":"2026-04-22T06:12:30.691884Z","end":"2026-04-22T06:12:30.853919Z","steps":["trace[139966992] 'range keys from in-memory index tree'  (duration: 160.255298ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:30.944403Z","caller":"traceutil/trace.go:171","msg":"trace[1864751070] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"113.859542ms","start":"2026-04-22T06:12:30.83051Z","end":"2026-04-22T06:12:30.944369Z","steps":["trace[1864751070] 'process raft request'  (duration: 113.598328ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:31.144146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.841081ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093079337 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-srdns\" mod_revision:4951 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-srdns\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-pushgateway-7c6f84b96c-srdns\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:12:31.144374Z","caller":"traceutil/trace.go:171","msg":"trace[731958738] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"186.712311ms","start":"2026-04-22T06:12:30.957639Z","end":"2026-04-22T06:12:31.144351Z","steps":["trace[731958738] 'process raft request'  (duration: 48.487163ms)","trace[731958738] 'compare'  (duration: 137.596255ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:33.125717Z","caller":"traceutil/trace.go:171","msg":"trace[135808943] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"177.331746ms","start":"2026-04-22T06:12:32.948344Z","end":"2026-04-22T06:12:33.125676Z","steps":["trace[135808943] 'process raft request'  (duration: 175.602574ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:33.140919Z","caller":"traceutil/trace.go:171","msg":"trace[1527576076] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"191.955968ms","start":"2026-04-22T06:12:32.94893Z","end":"2026-04-22T06:12:33.140886Z","steps":["trace[1527576076] 'process raft request'  (duration: 191.863436ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:33.140918Z","caller":"traceutil/trace.go:171","msg":"trace[1288958014] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"192.486919ms","start":"2026-04-22T06:12:32.948387Z","end":"2026-04-22T06:12:33.140874Z","steps":["trace[1288958014] 'process raft request'  (duration: 192.253765ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:33.141092Z","caller":"traceutil/trace.go:171","msg":"trace[806838428] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"191.259046ms","start":"2026-04-22T06:12:32.949806Z","end":"2026-04-22T06:12:33.141065Z","steps":["trace[806838428] 'process raft request'  (duration: 191.015842ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:33.141187Z","caller":"traceutil/trace.go:171","msg":"trace[1009733304] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"185.558769ms","start":"2026-04-22T06:12:32.955617Z","end":"2026-04-22T06:12:33.141176Z","steps":["trace[1009733304] 'process raft request'  (duration: 185.405337ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:37.296983Z","caller":"traceutil/trace.go:171","msg":"trace[1073155628] linearizableReadLoop","detail":"{readStateIndex:5540; appliedIndex:5539; }","duration":"117.117233ms","start":"2026-04-22T06:12:37.179807Z","end":"2026-04-22T06:12:37.296924Z","steps":["trace[1073155628] 'read index received'  (duration: 116.844258ms)","trace[1073155628] 'applied index is now lower than readState.Index'  (duration: 271.425µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:37.297086Z","caller":"traceutil/trace.go:171","msg":"trace[2124360585] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"128.177059ms","start":"2026-04-22T06:12:37.168875Z","end":"2026-04-22T06:12:37.297052Z","steps":["trace[2124360585] 'process raft request'  (duration: 127.818763ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:37.297307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.47477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lkp52\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T06:12:37.297359Z","caller":"traceutil/trace.go:171","msg":"trace[1810928540] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lkp52; range_end:; response_count:1; response_revision:5338; }","duration":"117.587612ms","start":"2026-04-22T06:12:37.179757Z","end":"2026-04-22T06:12:37.297345Z","steps":["trace[1810928540] 'agreement among raft nodes before linearized reading'  (duration: 117.385269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:41.140077Z","caller":"traceutil/trace.go:171","msg":"trace[1268201304] linearizableReadLoop","detail":"{readStateIndex:5570; appliedIndex:5569; }","duration":"100.997302ms","start":"2026-04-22T06:12:41.039056Z","end":"2026-04-22T06:12:41.140053Z","steps":["trace[1268201304] 'read index received'  (duration: 100.797829ms)","trace[1268201304] 'applied index is now lower than readState.Index'  (duration: 198.133µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:41.140228Z","caller":"traceutil/trace.go:171","msg":"trace[314103450] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"170.271355ms","start":"2026-04-22T06:12:40.969919Z","end":"2026-04-22T06:12:41.140191Z","steps":["trace[314103450] 'process raft request'  (duration: 169.954779ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:41.14059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.517702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17209"}
{"level":"info","ts":"2026-04-22T06:12:41.140653Z","caller":"traceutil/trace.go:171","msg":"trace[1349177797] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5367; }","duration":"101.642795ms","start":"2026-04-22T06:12:41.038995Z","end":"2026-04-22T06:12:41.140637Z","steps":["trace[1349177797] 'agreement among raft nodes before linearized reading'  (duration: 101.197667ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:41.541745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.862349ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093079723 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5358 > 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-22T06:12:41.542309Z","caller":"traceutil/trace.go:171","msg":"trace[288427687] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"214.386336ms","start":"2026-04-22T06:12:41.327873Z","end":"2026-04-22T06:12:41.542259Z","steps":["trace[288427687] 'process raft request'  (duration: 97.817864ms)","trace[288427687] 'compare'  (duration: 115.549054ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:41.54313Z","caller":"traceutil/trace.go:171","msg":"trace[1099678449] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"215.135291ms","start":"2026-04-22T06:12:41.327966Z","end":"2026-04-22T06:12:41.543101Z","steps":["trace[1099678449] 'process raft request'  (duration: 214.239944ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:41.543241Z","caller":"traceutil/trace.go:171","msg":"trace[1786570771] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5572; }","duration":"214.843295ms","start":"2026-04-22T06:12:41.328366Z","end":"2026-04-22T06:12:41.543209Z","steps":["trace[1786570771] 'read index received'  (duration: 49.114116ms)","trace[1786570771] 'applied index is now lower than readState.Index'  (duration: 165.728029ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:41.543293Z","caller":"traceutil/trace.go:171","msg":"trace[369637774] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"214.958858ms","start":"2026-04-22T06:12:41.328297Z","end":"2026-04-22T06:12:41.543256Z","steps":["trace[369637774] 'process raft request'  (duration: 214.800455ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:41.54344Z","caller":"traceutil/trace.go:171","msg":"trace[2061361043] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"214.58184ms","start":"2026-04-22T06:12:41.328818Z","end":"2026-04-22T06:12:41.543399Z","steps":["trace[2061361043] 'process raft request'  (duration: 214.334595ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:41.543467Z","caller":"traceutil/trace.go:171","msg":"trace[1618556999] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"215.157242ms","start":"2026-04-22T06:12:41.328249Z","end":"2026-04-22T06:12:41.543407Z","steps":["trace[1618556999] 'process raft request'  (duration: 214.773685ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:41.543619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.222373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:64725"}
{"level":"info","ts":"2026-04-22T06:12:41.543672Z","caller":"traceutil/trace.go:171","msg":"trace[805063107] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5375; }","duration":"215.353345ms","start":"2026-04-22T06:12:41.328306Z","end":"2026-04-22T06:12:41.543659Z","steps":["trace[805063107] 'agreement among raft nodes before linearized reading'  (duration: 215.03448ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:41.9411Z","caller":"traceutil/trace.go:171","msg":"trace[1012177688] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"169.748784ms","start":"2026-04-22T06:12:41.771296Z","end":"2026-04-22T06:12:41.941044Z","steps":["trace[1012177688] 'process raft request'  (duration: 169.393128ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.102414Z","caller":"traceutil/trace.go:171","msg":"trace[380395552] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"153.582793ms","start":"2026-04-22T06:12:41.948804Z","end":"2026-04-22T06:12:42.102386Z","steps":["trace[380395552] 'process raft request'  (duration: 153.43515ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.102416Z","caller":"traceutil/trace.go:171","msg":"trace[452050629] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"153.9408ms","start":"2026-04-22T06:12:41.948443Z","end":"2026-04-22T06:12:42.102384Z","steps":["trace[452050629] 'process raft request'  (duration: 153.628794ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.102726Z","caller":"traceutil/trace.go:171","msg":"trace[1531580612] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"153.336479ms","start":"2026-04-22T06:12:41.949368Z","end":"2026-04-22T06:12:42.102705Z","steps":["trace[1531580612] 'process raft request'  (duration: 152.934761ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.102735Z","caller":"traceutil/trace.go:171","msg":"trace[1628966648] linearizableReadLoop","detail":"{readStateIndex:5584; appliedIndex:5580; }","duration":"153.183996ms","start":"2026-04-22T06:12:41.949521Z","end":"2026-04-22T06:12:42.102705Z","steps":["trace[1628966648] 'read index received'  (duration: 29.49145ms)","trace[1628966648] 'applied index is now lower than readState.Index'  (duration: 123.691676ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:12:42.10298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.430121ms","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-22T06:12:42.102981Z","caller":"traceutil/trace.go:171","msg":"trace[1720980594] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"143.74ms","start":"2026-04-22T06:12:41.959218Z","end":"2026-04-22T06:12:42.102958Z","steps":["trace[1720980594] 'process raft request'  (duration: 143.340912ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.103044Z","caller":"traceutil/trace.go:171","msg":"trace[995248345] 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:5382; }","duration":"153.547533ms","start":"2026-04-22T06:12:41.949475Z","end":"2026-04-22T06:12:42.103023Z","steps":["trace[995248345] 'agreement among raft nodes before linearized reading'  (duration: 153.326239ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:12:42.311378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.601274ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093079744 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/monitoring/prometheus-operated\" mod_revision:4995 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/prometheus-operated\" value_size:783 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/prometheus-operated\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T06:12:42.311683Z","caller":"traceutil/trace.go:171","msg":"trace[707806712] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"201.307643ms","start":"2026-04-22T06:12:42.110333Z","end":"2026-04-22T06:12:42.31164Z","steps":["trace[707806712] 'process raft request'  (duration: 26.319401ms)","trace[707806712] 'compare'  (duration: 174.403721ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:42.311753Z","caller":"traceutil/trace.go:171","msg":"trace[910017014] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"200.790004ms","start":"2026-04-22T06:12:42.11094Z","end":"2026-04-22T06:12:42.31173Z","steps":["trace[910017014] 'process raft request'  (duration: 200.672832ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.31174Z","caller":"traceutil/trace.go:171","msg":"trace[47180966] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"201.16348ms","start":"2026-04-22T06:12:42.110534Z","end":"2026-04-22T06:12:42.311697Z","steps":["trace[47180966] 'process raft request'  (duration: 200.987187ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.312236Z","caller":"traceutil/trace.go:171","msg":"trace[2064658284] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"201.184561ms","start":"2026-04-22T06:12:42.111033Z","end":"2026-04-22T06:12:42.312217Z","steps":["trace[2064658284] 'process raft request'  (duration: 200.630231ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.312241Z","caller":"traceutil/trace.go:171","msg":"trace[369275272] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"190.97808ms","start":"2026-04-22T06:12:42.121246Z","end":"2026-04-22T06:12:42.312224Z","steps":["trace[369275272] 'process raft request'  (duration: 190.749396ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:12:42.509764Z","caller":"traceutil/trace.go:171","msg":"trace[1310966397] linearizableReadLoop","detail":"{readStateIndex:5591; appliedIndex:5590; }","duration":"131.111854ms","start":"2026-04-22T06:12:42.378616Z","end":"2026-04-22T06:12:42.509728Z","steps":["trace[1310966397] 'read index received'  (duration: 34.533073ms)","trace[1310966397] 'applied index is now lower than readState.Index'  (duration: 96.576661ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:12:42.509952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.308027ms","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-22T06:12:42.509927Z","caller":"traceutil/trace.go:171","msg":"trace[1961850768] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"175.980529ms","start":"2026-04-22T06:12:42.333899Z","end":"2026-04-22T06:12:42.509879Z","steps":["trace[1961850768] 'process raft request'  (duration: 79.316718ms)","trace[1961850768] 'compare'  (duration: 96.254854ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:12:42.510001Z","caller":"traceutil/trace.go:171","msg":"trace[143150388] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5388; }","duration":"131.439209ms","start":"2026-04-22T06:12:42.378548Z","end":"2026-04-22T06:12:42.509988Z","steps":["trace[143150388] 'agreement among raft nodes before linearized reading'  (duration: 131.312157ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:13.723295Z","caller":"traceutil/trace.go:171","msg":"trace[121671235] transaction","detail":"{read_only:false; response_revision:5669; number_of_response:1; }","duration":"162.03344ms","start":"2026-04-22T06:13:13.561231Z","end":"2026-04-22T06:13:13.723264Z","steps":["trace[121671235] 'process raft request'  (duration: 161.870927ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:13.813121Z","caller":"traceutil/trace.go:171","msg":"trace[599458827] linearizableReadLoop","detail":"{readStateIndex:5881; appliedIndex:5879; }","duration":"111.993758ms","start":"2026-04-22T06:13:13.701099Z","end":"2026-04-22T06:13:13.813093Z","steps":["trace[599458827] 'read index received'  (duration: 22.053514ms)","trace[599458827] 'applied index is now lower than readState.Index'  (duration: 89.939254ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:13:13.813275Z","caller":"traceutil/trace.go:171","msg":"trace[899991666] transaction","detail":"{read_only:false; response_revision:5670; number_of_response:1; }","duration":"152.891258ms","start":"2026-04-22T06:13:13.660371Z","end":"2026-04-22T06:13:13.813262Z","steps":["trace[899991666] 'process raft request'  (duration: 149.552685ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:13.813447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.583921ms","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-22T06:13:13.813547Z","caller":"traceutil/trace.go:171","msg":"trace[1397832470] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5670; }","duration":"111.742014ms","start":"2026-04-22T06:13:13.701785Z","end":"2026-04-22T06:13:13.813527Z","steps":["trace[1397832470] 'agreement among raft nodes before linearized reading'  (duration: 111.52622ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:13.813729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.622059ms","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-22T06:13:13.813783Z","caller":"traceutil/trace.go:171","msg":"trace[738046294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5670; }","duration":"112.726882ms","start":"2026-04-22T06:13:13.701046Z","end":"2026-04-22T06:13:13.813773Z","steps":["trace[738046294] 'agreement among raft nodes before linearized reading'  (duration: 112.62215ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:13.813823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.81883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T06:13:13.813865Z","caller":"traceutil/trace.go:171","msg":"trace[1764121168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5670; }","duration":"106.899442ms","start":"2026-04-22T06:13:13.706956Z","end":"2026-04-22T06:13:13.813856Z","steps":["trace[1764121168] 'agreement among raft nodes before linearized reading'  (duration: 106.8006ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:13.814076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.220787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-22T06:13:13.81416Z","caller":"traceutil/trace.go:171","msg":"trace[610959687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5670; }","duration":"107.33992ms","start":"2026-04-22T06:13:13.706799Z","end":"2026-04-22T06:13:13.814139Z","steps":["trace[610959687] 'agreement among raft nodes before linearized reading'  (duration: 107.094556ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:18.277917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.814156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T06:13:18.278026Z","caller":"traceutil/trace.go:171","msg":"trace[1181977248] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5704; }","duration":"179.01479ms","start":"2026-04-22T06:13:18.098989Z","end":"2026-04-22T06:13:18.278003Z","steps":["trace[1181977248] 'count revisions from in-memory index tree'  (duration: 178.681853ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:18.279404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.367916ms","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-22T06:13:18.279512Z","caller":"traceutil/trace.go:171","msg":"trace[31067076] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5704; }","duration":"163.527129ms","start":"2026-04-22T06:13:18.115962Z","end":"2026-04-22T06:13:18.27949Z","steps":["trace[31067076] 'range keys from in-memory index tree'  (duration: 161.884759ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:18.748848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.642343ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093080665 > lease_revoke:<id:7edf9db3c9a42248>","response":"size:27"}
{"level":"warn","ts":"2026-04-22T06:13:19.036191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.032521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19384"}
{"level":"info","ts":"2026-04-22T06:13:19.036311Z","caller":"traceutil/trace.go:171","msg":"trace[645666452] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5706; }","duration":"171.172353ms","start":"2026-04-22T06:13:18.865108Z","end":"2026-04-22T06:13:19.03628Z","steps":["trace[645666452] 'range keys from in-memory index tree'  (duration: 170.576322ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:19.359237Z","caller":"traceutil/trace.go:171","msg":"trace[881201880] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"102.99702ms","start":"2026-04-22T06:13:19.256199Z","end":"2026-04-22T06:13:19.359196Z","steps":["trace[881201880] 'process raft request'  (duration: 102.745325ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:20.471875Z","caller":"traceutil/trace.go:171","msg":"trace[1012630267] transaction","detail":"{read_only:false; response_revision:5712; number_of_response:1; }","duration":"496.725802ms","start":"2026-04-22T06:13:19.975112Z","end":"2026-04-22T06:13:20.471838Z","steps":["trace[1012630267] 'process raft request'  (duration: 448.731269ms)","trace[1012630267] 'compare'  (duration: 47.81187ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:13:20.472075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:19.97503Z","time spent":"496.939637ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5702 > 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-22T06:13:20.472383Z","caller":"traceutil/trace.go:171","msg":"trace[1859710066] transaction","detail":"{read_only:false; response_revision:5713; number_of_response:1; }","duration":"496.881106ms","start":"2026-04-22T06:13:19.975466Z","end":"2026-04-22T06:13:20.472347Z","steps":["trace[1859710066] 'process raft request'  (duration: 496.324485ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:20.472911Z","caller":"traceutil/trace.go:171","msg":"trace[1678925766] linearizableReadLoop","detail":"{readStateIndex:5927; appliedIndex:5923; }","duration":"393.945778ms","start":"2026-04-22T06:13:20.078945Z","end":"2026-04-22T06:13:20.472891Z","steps":["trace[1678925766] 'read index received'  (duration: 344.813932ms)","trace[1678925766] 'applied index is now lower than readState.Index'  (duration: 49.130276ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:13:20.473206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:19.975425Z","time spent":"497.150941ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5704 > 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-22T06:13:20.473339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.373226ms","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-22T06:13:20.473407Z","caller":"traceutil/trace.go:171","msg":"trace[1565665642] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5715; }","duration":"394.496309ms","start":"2026-04-22T06:13:20.078894Z","end":"2026-04-22T06:13:20.47339Z","steps":["trace[1565665642] 'agreement among raft nodes before linearized reading'  (duration: 394.374595ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:20.473446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:20.078871Z","time spent":"394.565809ms","remote":"127.0.0.1:55976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T06:13:20.473459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.576161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:13:20.473343Z","caller":"traceutil/trace.go:171","msg":"trace[1040984608] transaction","detail":"{read_only:false; response_revision:5714; number_of_response:1; }","duration":"497.767853ms","start":"2026-04-22T06:13:19.975541Z","end":"2026-04-22T06:13:20.473309Z","steps":["trace[1040984608] 'process raft request'  (duration: 496.497569ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:20.473508Z","caller":"traceutil/trace.go:171","msg":"trace[1653120327] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:5715; }","duration":"368.671862ms","start":"2026-04-22T06:13:20.104821Z","end":"2026-04-22T06:13:20.473493Z","steps":["trace[1653120327] 'agreement among raft nodes before linearized reading'  (duration: 368.586261ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:20.473542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:20.104797Z","time spent":"368.737003ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "}
{"level":"info","ts":"2026-04-22T06:13:20.473499Z","caller":"traceutil/trace.go:171","msg":"trace[1446128027] transaction","detail":"{read_only:false; response_revision:5715; number_of_response:1; }","duration":"497.061699ms","start":"2026-04-22T06:13:19.976392Z","end":"2026-04-22T06:13:20.473453Z","steps":["trace[1446128027] 'process raft request'  (duration: 496.430976ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:20.473637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:19.975521Z","time spent":"498.009047ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5700 > 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-22T06:13:20.473669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.965087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"}
{"level":"warn","ts":"2026-04-22T06:13:20.473649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.913796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:13:20.473738Z","caller":"traceutil/trace.go:171","msg":"trace[18829251] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5715; }","duration":"190.0743ms","start":"2026-04-22T06:13:20.283647Z","end":"2026-04-22T06:13:20.473722Z","steps":["trace[18829251] 'agreement among raft nodes before linearized reading'  (duration: 189.820015ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:20.473744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.051669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:13:20.473772Z","caller":"traceutil/trace.go:171","msg":"trace[487676355] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5715; }","duration":"190.095059ms","start":"2026-04-22T06:13:20.283648Z","end":"2026-04-22T06:13:20.473743Z","steps":["trace[487676355] 'agreement among raft nodes before linearized reading'  (duration: 189.830354ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:20.473788Z","caller":"traceutil/trace.go:171","msg":"trace[2095090464] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5715; }","duration":"190.130971ms","start":"2026-04-22T06:13:20.283647Z","end":"2026-04-22T06:13:20.473778Z","steps":["trace[2095090464] 'agreement among raft nodes before linearized reading'  (duration: 190.066029ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:20.473918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:19.976379Z","time spent":"497.312714ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5703 > 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-22T06:13:20.953701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.834419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T06:13:20.953834Z","caller":"traceutil/trace.go:171","msg":"trace[155225832] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:5715; }","duration":"306.005542ms","start":"2026-04-22T06:13:20.647795Z","end":"2026-04-22T06:13:20.953801Z","steps":["trace[155225832] 'count revisions from in-memory index tree'  (duration: 305.732907ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:20.953893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:20.64772Z","time spent":"306.159495ms","remote":"127.0.0.1:60550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T06:13:20.954052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.916483ms","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-22T06:13:20.954213Z","caller":"traceutil/trace.go:171","msg":"trace[78838635] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5715; }","duration":"175.116427ms","start":"2026-04-22T06:13:20.779028Z","end":"2026-04-22T06:13:20.954144Z","steps":["trace[78838635] 'range keys from in-memory index tree'  (duration: 174.578938ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:26.222017Z","caller":"traceutil/trace.go:171","msg":"trace[1732176547] linearizableReadLoop","detail":"{readStateIndex:5975; appliedIndex:5974; }","duration":"110.95966ms","start":"2026-04-22T06:13:26.111016Z","end":"2026-04-22T06:13:26.221976Z","steps":["trace[1732176547] 'read index received'  (duration: 110.722875ms)","trace[1732176547] 'applied index is now lower than readState.Index'  (duration: 234.604µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:13:26.22231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.260326ms","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-22T06:13:26.22236Z","caller":"traceutil/trace.go:171","msg":"trace[1342886086] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5761; }","duration":"111.370547ms","start":"2026-04-22T06:13:26.110976Z","end":"2026-04-22T06:13:26.222347Z","steps":["trace[1342886086] 'agreement among raft nodes before linearized reading'  (duration: 111.144992ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:26.22216Z","caller":"traceutil/trace.go:171","msg":"trace[1800577542] transaction","detail":"{read_only:false; response_revision:5761; number_of_response:1; }","duration":"115.80828ms","start":"2026-04-22T06:13:26.106307Z","end":"2026-04-22T06:13:26.222116Z","steps":["trace[1800577542] 'process raft request'  (duration: 115.407183ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:26.521146Z","caller":"traceutil/trace.go:171","msg":"trace[1296845668] transaction","detail":"{read_only:false; response_revision:5763; number_of_response:1; }","duration":"123.78955ms","start":"2026-04-22T06:13:26.397324Z","end":"2026-04-22T06:13:26.521114Z","steps":["trace[1296845668] 'process raft request'  (duration: 123.509665ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:34.286789Z","caller":"traceutil/trace.go:171","msg":"trace[1845368059] transaction","detail":"{read_only:false; response_revision:5818; number_of_response:1; }","duration":"106.985124ms","start":"2026-04-22T06:13:34.179773Z","end":"2026-04-22T06:13:34.286758Z","steps":["trace[1845368059] 'process raft request'  (duration: 106.658528ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:37.377522Z","caller":"traceutil/trace.go:171","msg":"trace[249188415] linearizableReadLoop","detail":"{readStateIndex:6052; appliedIndex:6051; }","duration":"119.771235ms","start":"2026-04-22T06:13:37.257719Z","end":"2026-04-22T06:13:37.37749Z","steps":["trace[249188415] 'read index received'  (duration: 119.261895ms)","trace[249188415] 'applied index is now lower than readState.Index'  (duration: 507.97µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:13:37.377691Z","caller":"traceutil/trace.go:171","msg":"trace[1976801045] transaction","detail":"{read_only:false; response_revision:5836; number_of_response:1; }","duration":"153.677734ms","start":"2026-04-22T06:13:37.223967Z","end":"2026-04-22T06:13:37.377645Z","steps":["trace[1976801045] 'process raft request'  (duration: 153.085132ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:13:37.377907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.162233ms","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-22T06:13:37.378039Z","caller":"traceutil/trace.go:171","msg":"trace[1913148635] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5836; }","duration":"120.353276ms","start":"2026-04-22T06:13:37.257649Z","end":"2026-04-22T06:13:37.378002Z","steps":["trace[1913148635] 'agreement among raft nodes before linearized reading'  (duration: 120.045431ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:38.813256Z","caller":"traceutil/trace.go:171","msg":"trace[1111619007] transaction","detail":"{read_only:false; response_revision:5850; number_of_response:1; }","duration":"321.861681ms","start":"2026-04-22T06:13:38.491334Z","end":"2026-04-22T06:13:38.813195Z","steps":["trace[1111619007] 'process raft request'  (duration: 298.219646ms)","trace[1111619007] 'compare'  (duration: 23.049794ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:13:38.813361Z","caller":"traceutil/trace.go:171","msg":"trace[276188410] linearizableReadLoop","detail":"{readStateIndex:6066; appliedIndex:6065; }","duration":"262.655494ms","start":"2026-04-22T06:13:38.55067Z","end":"2026-04-22T06:13:38.813325Z","steps":["trace[276188410] 'read index received'  (duration: 238.872156ms)","trace[276188410] 'applied index is now lower than readState.Index'  (duration: 23.781248ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:13:38.813489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:13:38.491317Z","time spent":"322.066384ms","remote":"127.0.0.1:53166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5800,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/keystone-fernet-setup\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/openstack/keystone-fernet-setup\" value_size:5746 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T06:13:38.831421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.726956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:1 size:5815"}
{"level":"info","ts":"2026-04-22T06:13:38.831533Z","caller":"traceutil/trace.go:171","msg":"trace[900930199] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:1; response_revision:5850; }","duration":"280.891568ms","start":"2026-04-22T06:13:38.550618Z","end":"2026-04-22T06:13:38.831509Z","steps":["trace[900930199] 'agreement among raft nodes before linearized reading'  (duration: 262.860018ms)","trace[900930199] 'range keys from in-memory index tree'  (duration: 17.866467ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:13:38.831528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.826557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T06:13:38.831562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.268003ms","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-22T06:13:38.831627Z","caller":"traceutil/trace.go:171","msg":"trace[1510945289] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5850; }","duration":"280.98752ms","start":"2026-04-22T06:13:38.550618Z","end":"2026-04-22T06:13:38.831605Z","steps":["trace[1510945289] 'agreement among raft nodes before linearized reading'  (duration: 262.883128ms)","trace[1510945289] 'range keys from in-memory index tree'  (duration: 17.957748ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:13:38.831627Z","caller":"traceutil/trace.go:171","msg":"trace[1269261583] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5850; }","duration":"249.370406ms","start":"2026-04-22T06:13:38.582241Z","end":"2026-04-22T06:13:38.831612Z","steps":["trace[1269261583] 'agreement among raft nodes before linearized reading'  (duration: 249.252104ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:13:50.111635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2863}
{"level":"info","ts":"2026-04-22T06:13:50.197415Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2863,"took":"83.94098ms","hash":3590252471,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":32956416,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-22T06:13:50.19751Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3590252471,"revision":2863,"compact-revision":-1}
{"level":"info","ts":"2026-04-22T06:18:13.357606Z","caller":"traceutil/trace.go:171","msg":"trace[83789490] transaction","detail":"{read_only:false; response_revision:7928; number_of_response:1; }","duration":"105.981504ms","start":"2026-04-22T06:18:13.251572Z","end":"2026-04-22T06:18:13.357553Z","steps":["trace[83789490] 'process raft request'  (duration: 105.80934ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:14.741463Z","caller":"traceutil/trace.go:171","msg":"trace[1391201472] transaction","detail":"{read_only:false; response_revision:7932; number_of_response:1; }","duration":"375.356331ms","start":"2026-04-22T06:18:14.366081Z","end":"2026-04-22T06:18:14.741437Z","steps":["trace[1391201472] 'process raft request'  (duration: 375.197318ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:14.741639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:14.366061Z","time spent":"375.477133ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:7915 > 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":"info","ts":"2026-04-22T06:18:15.022955Z","caller":"traceutil/trace.go:171","msg":"trace[1512967203] transaction","detail":"{read_only:false; response_revision:7933; number_of_response:1; }","duration":"652.998844ms","start":"2026-04-22T06:18:14.36993Z","end":"2026-04-22T06:18:15.022929Z","steps":["trace[1512967203] 'process raft request'  (duration: 652.830141ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:15.023112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:14.369912Z","time spent":"653.117426ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:7913 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-22T06:18:15.023322Z","caller":"traceutil/trace.go:171","msg":"trace[2138771344] transaction","detail":"{read_only:false; response_revision:7934; number_of_response:1; }","duration":"653.35389ms","start":"2026-04-22T06:18:14.369938Z","end":"2026-04-22T06:18:15.023292Z","steps":["trace[2138771344] 'process raft request'  (duration: 652.957133ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:15.023349Z","caller":"traceutil/trace.go:171","msg":"trace[482090998] linearizableReadLoop","detail":"{readStateIndex:8217; appliedIndex:8214; }","duration":"533.356454ms","start":"2026-04-22T06:18:14.48996Z","end":"2026-04-22T06:18:15.023316Z","steps":["trace[482090998] 'read index received'  (duration: 251.300698ms)","trace[482090998] 'applied index is now lower than readState.Index'  (duration: 282.054246ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:18:15.023449Z","caller":"traceutil/trace.go:171","msg":"trace[134740354] transaction","detail":"{read_only:false; response_revision:7935; number_of_response:1; }","duration":"467.839891ms","start":"2026-04-22T06:18:14.555586Z","end":"2026-04-22T06:18:15.023426Z","steps":["trace[134740354] 'process raft request'  (duration: 467.567036ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:15.023472Z","caller":"traceutil/trace.go:171","msg":"trace[44875607] transaction","detail":"{read_only:false; response_revision:7936; number_of_response:1; }","duration":"394.320997ms","start":"2026-04-22T06:18:14.62914Z","end":"2026-04-22T06:18:15.023461Z","steps":["trace[44875607] 'process raft request'  (duration: 394.128834ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:15.023466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:14.369923Z","time spent":"653.474122ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:7914 > 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-22T06:18:15.023583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:14.629119Z","time spent":"394.382518ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:7918 > 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-22T06:18:15.023747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.963426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-04-22T06:18:15.023787Z","caller":"traceutil/trace.go:171","msg":"trace[861300439] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7936; }","duration":"137.045608ms","start":"2026-04-22T06:18:14.886731Z","end":"2026-04-22T06:18:15.023777Z","steps":["trace[861300439] 'agreement among raft nodes before linearized reading'  (duration: 136.895905ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:15.023853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.884524ms","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-22T06:18:15.023907Z","caller":"traceutil/trace.go:171","msg":"trace[996715104] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7936; }","duration":"533.953005ms","start":"2026-04-22T06:18:14.489939Z","end":"2026-04-22T06:18:15.023892Z","steps":["trace[996715104] 'agreement among raft nodes before linearized reading'  (duration: 533.806322ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:15.023944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:14.48993Z","time spent":"534.007726ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:18:15.024028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.915591ms","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-22T06:18:15.024068Z","caller":"traceutil/trace.go:171","msg":"trace[91954490] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7936; }","duration":"123.990273ms","start":"2026-04-22T06:18:14.900067Z","end":"2026-04-22T06:18:15.024057Z","steps":["trace[91954490] 'agreement among raft nodes before linearized reading'  (duration: 123.887351ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:15.024269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:14.555558Z","time spent":"467.929123ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7917 > 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-22T06:18:27.014844Z","caller":"traceutil/trace.go:171","msg":"trace[442444767] linearizableReadLoop","detail":"{readStateIndex:8280; appliedIndex:8279; }","duration":"111.808273ms","start":"2026-04-22T06:18:26.903005Z","end":"2026-04-22T06:18:27.014813Z","steps":["trace[442444767] 'read index received'  (duration: 111.388525ms)","trace[442444767] 'applied index is now lower than readState.Index'  (duration: 418.278µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:18:27.015019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.989637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T06:18:27.015065Z","caller":"traceutil/trace.go:171","msg":"trace[976129557] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:7994; }","duration":"112.065508ms","start":"2026-04-22T06:18:26.902987Z","end":"2026-04-22T06:18:27.015052Z","steps":["trace[976129557] 'agreement among raft nodes before linearized reading'  (duration: 111.944996ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:27.014981Z","caller":"traceutil/trace.go:171","msg":"trace[2141266219] transaction","detail":"{read_only:false; response_revision:7994; number_of_response:1; }","duration":"224.439542ms","start":"2026-04-22T06:18:26.790476Z","end":"2026-04-22T06:18:27.014915Z","steps":["trace[2141266219] 'process raft request'  (duration: 224.089906ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:27.548281Z","caller":"traceutil/trace.go:171","msg":"trace[1443139509] transaction","detail":"{read_only:false; response_revision:8002; number_of_response:1; }","duration":"108.436001ms","start":"2026-04-22T06:18:27.439819Z","end":"2026-04-22T06:18:27.548255Z","steps":["trace[1443139509] 'process raft request'  (duration: 108.310049ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:28.844248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.427786ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093086907 > lease_revoke:<id:7edf9db3c9a43bd5>","response":"size:27"}
{"level":"info","ts":"2026-04-22T06:18:29.249679Z","caller":"traceutil/trace.go:171","msg":"trace[532734720] transaction","detail":"{read_only:false; response_revision:8007; number_of_response:1; }","duration":"103.945125ms","start":"2026-04-22T06:18:29.145698Z","end":"2026-04-22T06:18:29.249643Z","steps":["trace[532734720] 'process raft request'  (duration: 31.555563ms)","trace[532734720] 'compare'  (duration: 72.117997ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:18:29.448871Z","caller":"traceutil/trace.go:171","msg":"trace[14670482] linearizableReadLoop","detail":"{readStateIndex:8297; appliedIndex:8294; }","duration":"167.4724ms","start":"2026-04-22T06:18:29.28137Z","end":"2026-04-22T06:18:29.448843Z","steps":["trace[14670482] 'read index received'  (duration: 76.699582ms)","trace[14670482] 'applied index is now lower than readState.Index'  (duration: 90.771568ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:18:29.449022Z","caller":"traceutil/trace.go:171","msg":"trace[310419650] transaction","detail":"{read_only:false; response_revision:8008; number_of_response:1; }","duration":"194.745514ms","start":"2026-04-22T06:18:29.25423Z","end":"2026-04-22T06:18:29.448976Z","steps":["trace[310419650] 'process raft request'  (duration: 103.845533ms)","trace[310419650] 'compare'  (duration: 90.415852ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:18:29.449118Z","caller":"traceutil/trace.go:171","msg":"trace[839841067] transaction","detail":"{read_only:false; response_revision:8009; number_of_response:1; }","duration":"193.904868ms","start":"2026-04-22T06:18:29.255181Z","end":"2026-04-22T06:18:29.449086Z","steps":["trace[839841067] 'process raft request'  (duration: 193.543381ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:29.449198Z","caller":"traceutil/trace.go:171","msg":"trace[2127154518] transaction","detail":"{read_only:false; response_revision:8010; number_of_response:1; }","duration":"193.392729ms","start":"2026-04-22T06:18:29.255755Z","end":"2026-04-22T06:18:29.449148Z","steps":["trace[2127154518] 'process raft request'  (duration: 193.035111ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:29.449338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.890018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:18:29.44946Z","caller":"traceutil/trace.go:171","msg":"trace[420268571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8010; }","duration":"168.124003ms","start":"2026-04-22T06:18:29.281312Z","end":"2026-04-22T06:18:29.449436Z","steps":["trace[420268571] 'agreement among raft nodes before linearized reading'  (duration: 167.743505ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:50.118898Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5952}
{"level":"info","ts":"2026-04-22T06:18:50.208701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5952,"took":"87.055547ms","hash":3109313716,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":26136576,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-22T06:18:50.208776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3109313716,"revision":5952,"compact-revision":2863}
{"level":"info","ts":"2026-04-22T06:18:55.490279Z","caller":"traceutil/trace.go:171","msg":"trace[418498258] transaction","detail":"{read_only:false; response_revision:8200; number_of_response:1; }","duration":"327.577322ms","start":"2026-04-22T06:18:55.162675Z","end":"2026-04-22T06:18:55.490253Z","steps":["trace[418498258] 'process raft request'  (duration: 327.397468ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:55.490434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:55.16265Z","time spent":"327.701625ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8189 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-22T06:18:55.537719Z","caller":"traceutil/trace.go:171","msg":"trace[1104195751] linearizableReadLoop","detail":"{readStateIndex:8496; appliedIndex:8493; }","duration":"255.633357ms","start":"2026-04-22T06:18:55.282051Z","end":"2026-04-22T06:18:55.537684Z","steps":["trace[1104195751] 'read index received'  (duration: 208.15396ms)","trace[1104195751] 'applied index is now lower than readState.Index'  (duration: 47.478177ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:18:55.537792Z","caller":"traceutil/trace.go:171","msg":"trace[1753929458] transaction","detail":"{read_only:false; response_revision:8201; number_of_response:1; }","duration":"323.674959ms","start":"2026-04-22T06:18:55.214083Z","end":"2026-04-22T06:18:55.537758Z","steps":["trace[1753929458] 'process raft request'  (duration: 323.342463ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:55.537823Z","caller":"traceutil/trace.go:171","msg":"trace[1189302873] transaction","detail":"{read_only:false; response_revision:8202; number_of_response:1; }","duration":"323.004728ms","start":"2026-04-22T06:18:55.214793Z","end":"2026-04-22T06:18:55.537798Z","steps":["trace[1189302873] 'process raft request'  (duration: 322.820994ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:55.537911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.841092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T06:18:55.537953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:55.214778Z","time spent":"323.098679ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8191 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-22T06:18:55.537964Z","caller":"traceutil/trace.go:171","msg":"trace[1325867441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8202; }","duration":"255.973655ms","start":"2026-04-22T06:18:55.281976Z","end":"2026-04-22T06:18:55.537949Z","steps":["trace[1325867441] 'agreement among raft nodes before linearized reading'  (duration: 255.871213ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:55.537964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:18:55.214059Z","time spent":"323.805073ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8190 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-22T06:18:55.538017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.008091ms","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-22T06:18:55.538081Z","caller":"traceutil/trace.go:171","msg":"trace[572608535] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8202; }","duration":"152.104374ms","start":"2026-04-22T06:18:55.385957Z","end":"2026-04-22T06:18:55.538061Z","steps":["trace[572608535] 'agreement among raft nodes before linearized reading'  (duration: 151.91901ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:18:55.773376Z","caller":"traceutil/trace.go:171","msg":"trace[574067515] linearizableReadLoop","detail":"{readStateIndex:8497; appliedIndex:8496; }","duration":"193.960525ms","start":"2026-04-22T06:18:55.57939Z","end":"2026-04-22T06:18:55.773351Z","steps":["trace[574067515] 'read index received'  (duration: 193.793042ms)","trace[574067515] 'applied index is now lower than readState.Index'  (duration: 164.553µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:18:55.773423Z","caller":"traceutil/trace.go:171","msg":"trace[1574780724] transaction","detail":"{read_only:false; response_revision:8203; number_of_response:1; }","duration":"231.088419ms","start":"2026-04-22T06:18:55.542306Z","end":"2026-04-22T06:18:55.773394Z","steps":["trace[1574780724] 'process raft request'  (duration: 230.856695ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:55.773665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.256891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-22T06:18:55.773711Z","caller":"traceutil/trace.go:171","msg":"trace[2078035289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8203; }","duration":"194.355442ms","start":"2026-04-22T06:18:55.579344Z","end":"2026-04-22T06:18:55.773699Z","steps":["trace[2078035289] 'agreement among raft nodes before linearized reading'  (duration: 194.153259ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:55.773696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.801242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-22T06:18:55.773774Z","caller":"traceutil/trace.go:171","msg":"trace[1147520707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8203; }","duration":"193.927754ms","start":"2026-04-22T06:18:55.579828Z","end":"2026-04-22T06:18:55.773756Z","steps":["trace[1147520707] 'agreement among raft nodes before linearized reading'  (duration: 193.6819ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:18:55.773791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.225451ms","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-22T06:18:55.77385Z","caller":"traceutil/trace.go:171","msg":"trace[1845649090] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8203; }","duration":"193.327533ms","start":"2026-04-22T06:18:55.580507Z","end":"2026-04-22T06:18:55.773835Z","steps":["trace[1845649090] 'agreement among raft nodes before linearized reading'  (duration: 193.047458ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:08.401416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.856669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:19:08.40151Z","caller":"traceutil/trace.go:171","msg":"trace[1486707316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8315; }","duration":"121.011461ms","start":"2026-04-22T06:19:08.28048Z","end":"2026-04-22T06:19:08.401491Z","steps":["trace[1486707316] 'range keys from in-memory index tree'  (duration: 120.770937ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:08.998706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.637507ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142199164093087907 > lease_revoke:<id:7edf9db3c9a43f2b>","response":"size:27"}
{"level":"info","ts":"2026-04-22T06:19:08.999266Z","caller":"traceutil/trace.go:171","msg":"trace[1591634230] linearizableReadLoop","detail":"{readStateIndex:8615; appliedIndex:8614; }","duration":"431.136508ms","start":"2026-04-22T06:19:08.568104Z","end":"2026-04-22T06:19:08.99924Z","steps":["trace[1591634230] 'read index received'  (duration: 266.895479ms)","trace[1591634230] 'applied index is now lower than readState.Index'  (duration: 164.238319ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T06:19:08.999388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.26166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T06:19:08.999431Z","caller":"traceutil/trace.go:171","msg":"trace[781818119] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:8315; }","duration":"431.353442ms","start":"2026-04-22T06:19:08.568066Z","end":"2026-04-22T06:19:08.999419Z","steps":["trace[781818119] 'agreement among raft nodes before linearized reading'  (duration: 431.24955ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:08.999475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:08.568049Z","time spent":"431.415323ms","remote":"127.0.0.1:47084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "}
{"level":"info","ts":"2026-04-22T06:19:09.000091Z","caller":"traceutil/trace.go:171","msg":"trace[1525229854] transaction","detail":"{read_only:false; response_revision:8316; number_of_response:1; }","duration":"296.141214ms","start":"2026-04-22T06:19:08.703905Z","end":"2026-04-22T06:19:09.000046Z","steps":["trace[1525229854] 'process raft request'  (duration: 295.89448ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:19:10.235392Z","caller":"traceutil/trace.go:171","msg":"trace[774622227] linearizableReadLoop","detail":"{readStateIndex:8622; appliedIndex:8621; }","duration":"363.719848ms","start":"2026-04-22T06:19:09.871648Z","end":"2026-04-22T06:19:10.235368Z","steps":["trace[774622227] 'read index received'  (duration: 363.463353ms)","trace[774622227] 'applied index is now lower than readState.Index'  (duration: 255.365µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:19:10.235497Z","caller":"traceutil/trace.go:171","msg":"trace[878374413] transaction","detail":"{read_only:false; response_revision:8322; number_of_response:1; }","duration":"378.379442ms","start":"2026-04-22T06:19:09.857087Z","end":"2026-04-22T06:19:10.235466Z","steps":["trace[878374413] 'process raft request'  (duration: 378.103837ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:10.235643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.974352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-04-22T06:19:10.235661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.857067Z","time spent":"378.511985ms","remote":"127.0.0.1:47026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:8247 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7343 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >"}
{"level":"info","ts":"2026-04-22T06:19:10.235688Z","caller":"traceutil/trace.go:171","msg":"trace[1703437073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8322; }","duration":"364.048594ms","start":"2026-04-22T06:19:09.871628Z","end":"2026-04-22T06:19:10.235677Z","steps":["trace[1703437073] 'agreement among raft nodes before linearized reading'  (duration: 363.881571ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:10.235737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.87162Z","time spent":"364.102645ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-22T06:19:10.235808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.101534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T06:19:10.235882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.128062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lkp52\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-04-22T06:19:10.235963Z","caller":"traceutil/trace.go:171","msg":"trace[1873227616] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lkp52; range_end:; response_count:1; response_revision:8322; }","duration":"123.217993ms","start":"2026-04-22T06:19:10.112727Z","end":"2026-04-22T06:19:10.235945Z","steps":["trace[1873227616] 'agreement among raft nodes before linearized reading'  (duration: 123.005419ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:10.23603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.131377ms","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-22T06:19:10.235902Z","caller":"traceutil/trace.go:171","msg":"trace[665444854] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:8322; }","duration":"342.236056ms","start":"2026-04-22T06:19:09.893645Z","end":"2026-04-22T06:19:10.235881Z","steps":["trace[665444854] 'agreement among raft nodes before linearized reading'  (duration: 341.927441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:19:10.236077Z","caller":"traceutil/trace.go:171","msg":"trace[1543312946] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8322; }","duration":"325.199727ms","start":"2026-04-22T06:19:09.910865Z","end":"2026-04-22T06:19:10.236065Z","steps":["trace[1543312946] 'agreement among raft nodes before linearized reading'  (duration: 325.051375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:10.236108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.910853Z","time spent":"325.248739ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:19:10.23612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.552186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-04-22T06:19:10.236171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.467804ms","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-22T06:19:10.236191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.893631Z","time spent":"342.46412ms","remote":"127.0.0.1:53172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":2,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"info","ts":"2026-04-22T06:19:10.23624Z","caller":"traceutil/trace.go:171","msg":"trace[1013098132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8322; }","duration":"324.701379ms","start":"2026-04-22T06:19:09.911514Z","end":"2026-04-22T06:19:10.236215Z","steps":["trace[1013098132] 'agreement among raft nodes before linearized reading'  (duration: 324.332012ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:19:10.236254Z","caller":"traceutil/trace.go:171","msg":"trace[150488941] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8322; }","duration":"324.566655ms","start":"2026-04-22T06:19:09.911666Z","end":"2026-04-22T06:19:10.236233Z","steps":["trace[150488941] 'agreement among raft nodes before linearized reading'  (duration: 324.088037ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:10.236297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.911472Z","time spent":"324.81702ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-22T06:19:10.2363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.911656Z","time spent":"324.633706ms","remote":"127.0.0.1:53190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-04-22T06:19:10.236702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.76617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-22T06:19:10.236754Z","caller":"traceutil/trace.go:171","msg":"trace[1700225016] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8322; }","duration":"324.852612ms","start":"2026-04-22T06:19:09.911885Z","end":"2026-04-22T06:19:10.236738Z","steps":["trace[1700225016] 'agreement among raft nodes before linearized reading'  (duration: 324.088967ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T06:19:10.236786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:19:09.911875Z","time spent":"324.903382ms","remote":"127.0.0.1:53190","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":"info","ts":"2026-04-22T06:20:15.941941Z","caller":"traceutil/trace.go:171","msg":"trace[522825634] transaction","detail":"{read_only:false; response_revision:8945; number_of_response:1; }","duration":"105.682455ms","start":"2026-04-22T06:20:15.836235Z","end":"2026-04-22T06:20:15.941917Z","steps":["trace[522825634] 'process raft request'  (duration: 105.514741ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:20:16.001181Z","caller":"traceutil/trace.go:171","msg":"trace[259973746] transaction","detail":"{read_only:false; response_revision:8946; number_of_response:1; }","duration":"145.277945ms","start":"2026-04-22T06:20:15.855877Z","end":"2026-04-22T06:20:16.001155Z","steps":["trace[259973746] 'process raft request'  (duration: 145.092632ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T06:20:16.138354Z","caller":"traceutil/trace.go:171","msg":"trace[1798469074] transaction","detail":"{read_only:false; response_revision:8948; number_of_response:1; }","duration":"132.935215ms","start":"2026-04-22T06:20:16.005384Z","end":"2026-04-22T06:20:16.138319Z","steps":["trace[1798469074] 'process raft request'  (duration: 116.171412ms)","trace[1798469074] 'compare'  (duration: 16.389426ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T06:20:17.819184Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243d.wal"}
{"level":"info","ts":"2026-04-22T06:21:41.113678Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1686e9b1ea717edf","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-22T06:21:41.118764Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-22T06:21:41.118894Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-22T06:23:50.125604Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8130}
{"level":"info","ts":"2026-04-22T06:23:50.196609Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8130,"took":"68.572406ms","hash":3617581121,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":28844032,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-22T06:23:50.196674Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3617581121,"revision":8130,"compact-revision":5952}
{"level":"info","ts":"2026-04-22T06:28:50.135703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10555}
{"level":"info","ts":"2026-04-22T06:28:50.221112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10555,"took":"82.946587ms","hash":621672998,"current-db-size-bytes":58413056,"current-db-size":"58 MB","current-db-size-in-use-bytes":19779584,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-22T06:28:50.221201Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":621672998,"revision":10555,"compact-revision":8130}