{"level":"warn","ts":"2026-05-04T18:55:05.077573Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T18:55:05.077665Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-04T18:55:05.077737Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T18:55:05.077746Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]}
{"level":"info","ts":"2026-05-04T18:55:05.077764Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-04T18:55:05.078393Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]}
{"level":"info","ts":"2026-05-04T18:55:05.078458Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-04T18:55:05.082748Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.062415ms"}
{"level":"info","ts":"2026-05-04T18:55:05.090735Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"}
{"level":"info","ts":"2026-05-04T18:55:05.090801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-04T18:55:05.090832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"}
{"level":"info","ts":"2026-05-04T18:55:05.090848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-04T18:55:05.090859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"}
{"level":"info","ts":"2026-05-04T18:55:05.090894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"}
{"level":"warn","ts":"2026-05-04T18:55:05.099524Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-04T18:55:05.100932Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-04T18:55:05.103097Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-04T18:55:05.107974Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-04T18:55:05.108391Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-04T18:55:05.108552Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T18:55:05.108636Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T18:55:05.108646Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T18:55:05.1092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"}
{"level":"info","ts":"2026-05-04T18:55:05.114228Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]}
{"level":"info","ts":"2026-05-04T18:55:05.115148Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-04T18:55:05.115362Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-04T18:55:05.115381Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"}
{"level":"info","ts":"2026-05-04T18:55:05.115424Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-04T18:55:05.115424Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"}
{"level":"info","ts":"2026-05-04T18:55:05.891966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-04T18:55:05.893102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-04T18:55:05.893154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"}
{"level":"info","ts":"2026-05-04T18:55:05.893182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"}
{"level":"info","ts":"2026-05-04T18:55:05.89322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"}
{"level":"info","ts":"2026-05-04T18:55:05.893243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"}
{"level":"info","ts":"2026-05-04T18:55:05.89326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"}
{"level":"info","ts":"2026-05-04T18:55:05.894561Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:55:05.895607Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T18:55:05.895673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T18:55:05.895612Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-04T18:55:05.89616Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-04T18:55:05.896182Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-04T18:55:05.898727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-04T18:55:05.899042Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"}
{"level":"info","ts":"2026-05-04T18:55:05.900237Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:55:05.900313Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:55:05.900336Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:55:13.339803Z","caller":"traceutil/trace.go:171","msg":"trace[1987043452] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"101.959733ms","start":"2026-05-04T18:55:13.237816Z","end":"2026-05-04T18:55:13.339776Z","steps":["trace[1987043452] 'process raft request'  (duration: 101.804202ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:55:13.348492Z","caller":"traceutil/trace.go:171","msg":"trace[1175434819] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:333; }","duration":"105.042761ms","start":"2026-05-04T18:55:13.243432Z","end":"2026-05-04T18:55:13.348475Z","steps":["trace[1175434819] 'read index received'  (duration: 96.161838ms)","trace[1175434819] 'applied index is now lower than readState.Index'  (duration: 8.880133ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:55:13.348671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.216032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-05-04T18:55:13.348738Z","caller":"traceutil/trace.go:171","msg":"trace[212426596] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:325; }","duration":"105.338663ms","start":"2026-05-04T18:55:13.243387Z","end":"2026-05-04T18:55:13.348725Z","steps":["trace[212426596] 'agreement among raft nodes before linearized reading'  (duration: 105.223873ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:55:13.348717Z","caller":"traceutil/trace.go:171","msg":"trace[1259747186] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"110.070871ms","start":"2026-05-04T18:55:13.238459Z","end":"2026-05-04T18:55:13.34853Z","steps":["trace[1259747186] 'process raft request'  (duration: 109.94778ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:55:23.257368Z","caller":"traceutil/trace.go:171","msg":"trace[2041612944] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"208.011771ms","start":"2026-05-04T18:55:23.049331Z","end":"2026-05-04T18:55:23.257343Z","steps":["trace[2041612944] 'process raft request'  (duration: 207.87358ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:55:40.474629Z","caller":"traceutil/trace.go:171","msg":"trace[2110861566] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"452.552325ms","start":"2026-05-04T18:55:40.022026Z","end":"2026-05-04T18:55:40.474578Z","steps":["trace[2110861566] 'process raft request'  (duration: 450.522343ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:55:40.475179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:55:40.021994Z","time spent":"452.712586ms","remote":"127.0.0.1:56510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:606 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036197 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-04T18:55:41.071193Z","caller":"traceutil/trace.go:171","msg":"trace[1815611432] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"286.084812ms","start":"2026-05-04T18:55:40.785083Z","end":"2026-05-04T18:55:41.071167Z","steps":["trace[1815611432] 'read index received'  (duration: 285.946271ms)","trace[1815611432] 'applied index is now lower than readState.Index'  (duration: 137.611µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:55:41.071306Z","caller":"traceutil/trace.go:171","msg":"trace[1977539073] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"534.873703ms","start":"2026-05-04T18:55:40.53642Z","end":"2026-05-04T18:55:41.071294Z","steps":["trace[1977539073] 'process raft request'  (duration: 534.612161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:55:41.071394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:55:40.536396Z","time spent":"534.934713ms","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-05-04T18:55:41.071488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.386964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-687cz\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-04T18:55:41.071561Z","caller":"traceutil/trace.go:171","msg":"trace[1514540119] range","detail":"{range_begin:/registry/pods/kube-system/cilium-687cz; range_end:; response_count:1; response_revision:615; }","duration":"286.502815ms","start":"2026-05-04T18:55:40.785038Z","end":"2026-05-04T18:55:41.071541Z","steps":["trace[1514540119] 'agreement among raft nodes before linearized reading'  (duration: 286.268454ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:55:41.123451Z","caller":"traceutil/trace.go:171","msg":"trace[1265433285] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"279.943256ms","start":"2026-05-04T18:55:40.84347Z","end":"2026-05-04T18:55:41.123413Z","steps":["trace[1265433285] 'process raft request'  (duration: 258.836252ms)","trace[1265433285] 'compare'  (duration: 20.903493ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:55:41.123715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.238637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:55:41.123842Z","caller":"traceutil/trace.go:171","msg":"trace[1529110441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"121.413597ms","start":"2026-05-04T18:55:41.002405Z","end":"2026-05-04T18:55:41.123818Z","steps":["trace[1529110441] 'agreement among raft nodes before linearized reading'  (duration: 121.235116ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:55:56.831139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.948292ms","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-05-04T18:55:56.831331Z","caller":"traceutil/trace.go:171","msg":"trace[563386437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:781; }","duration":"386.148513ms","start":"2026-05-04T18:55:56.445089Z","end":"2026-05-04T18:55:56.831237Z","steps":["trace[563386437] 'range keys from in-memory index tree'  (duration: 385.72227ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:55:56.831646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:55:56.445072Z","time spent":"386.554535ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-04T18:56:29.340548Z","caller":"traceutil/trace.go:171","msg":"trace[217734462] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"298.527665ms","start":"2026-05-04T18:56:29.041992Z","end":"2026-05-04T18:56:29.34052Z","steps":["trace[217734462] 'process raft request'  (duration: 264.500104ms)","trace[217734462] 'compare'  (duration: 33.915371ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:56:29.380842Z","caller":"traceutil/trace.go:171","msg":"trace[853564982] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"338.532041ms","start":"2026-05-04T18:56:29.042289Z","end":"2026-05-04T18:56:29.380821Z","steps":["trace[853564982] 'process raft request'  (duration: 338.417231ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:56:29.381213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:56:29.04228Z","time spent":"338.873193ms","remote":"127.0.0.1:56652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2914,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:801 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2836 >> failure:<request_range:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" > >"}
{"level":"warn","ts":"2026-05-04T18:57:16.932391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.860396ms","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-05-04T18:57:16.93247Z","caller":"traceutil/trace.go:171","msg":"trace[1778531418] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1861; }","duration":"237.022097ms","start":"2026-05-04T18:57:16.69543Z","end":"2026-05-04T18:57:16.932452Z","steps":["trace[1778531418] 'count revisions from in-memory index tree'  (duration: 236.774581ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:16.932787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.771503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T18:57:16.932875Z","caller":"traceutil/trace.go:171","msg":"trace[14512783] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1861; }","duration":"340.915002ms","start":"2026-05-04T18:57:16.591939Z","end":"2026-05-04T18:57:16.932854Z","steps":["trace[14512783] 'range keys from in-memory index tree'  (duration: 340.506566ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:16.932923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:16.591909Z","time spent":"341.004078ms","remote":"127.0.0.1:42202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-04T18:57:16.93279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.066371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69755111-2201-4e6c-95d6-84ee7c2a5a91\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-04T18:57:16.933054Z","caller":"traceutil/trace.go:171","msg":"trace[1490759849] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69755111-2201-4e6c-95d6-84ee7c2a5a91; range_end:; response_count:1; response_revision:1861; }","duration":"296.302926ms","start":"2026-05-04T18:57:16.636687Z","end":"2026-05-04T18:57:16.93299Z","steps":["trace[1490759849] 'range keys from in-memory index tree'  (duration: 295.843796ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.195594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.998628ms","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-05-04T18:57:30.195717Z","caller":"traceutil/trace.go:171","msg":"trace[1297089240] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1963; }","duration":"751.161358ms","start":"2026-05-04T18:57:29.444534Z","end":"2026-05-04T18:57:30.195695Z","steps":["trace[1297089240] 'range keys from in-memory index tree'  (duration: 750.743883ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.195804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:29.444518Z","time spent":"751.262354ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T18:57:30.195843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.255473ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150841029399193 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1955 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:57:30.195963Z","caller":"traceutil/trace.go:171","msg":"trace[140756698] linearizableReadLoop","detail":"{readStateIndex:2039; appliedIndex:2038; }","duration":"539.002596ms","start":"2026-05-04T18:57:29.656944Z","end":"2026-05-04T18:57:30.195947Z","steps":["trace[140756698] 'read index received'  (duration: 404.379461ms)","trace[140756698] 'applied index is now lower than readState.Index'  (duration: 134.622005ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:57:30.196161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.221159ms","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-05-04T18:57:30.196218Z","caller":"traceutil/trace.go:171","msg":"trace[1137563964] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1964; }","duration":"539.307604ms","start":"2026-05-04T18:57:29.656899Z","end":"2026-05-04T18:57:30.196206Z","steps":["trace[1137563964] 'agreement among raft nodes before linearized reading'  (duration: 539.172716ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.196259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:29.656875Z","time spent":"539.375568ms","remote":"127.0.0.1:56676","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":"info","ts":"2026-05-04T18:57:30.196133Z","caller":"traceutil/trace.go:171","msg":"trace[102220392] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"642.246491ms","start":"2026-05-04T18:57:29.55385Z","end":"2026-05-04T18:57:30.196096Z","steps":["trace[102220392] 'process raft request'  (duration: 507.472016ms)","trace[102220392] 'compare'  (duration: 133.886762ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:57:30.196526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:29.553827Z","time spent":"642.629513ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1955 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-04T18:57:30.208107Z","caller":"traceutil/trace.go:171","msg":"trace[1904802945] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"196.468638ms","start":"2026-05-04T18:57:30.011616Z","end":"2026-05-04T18:57:30.208084Z","steps":["trace[1904802945] 'process raft request'  (duration: 196.32975ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.208194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.077342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T18:57:30.208235Z","caller":"traceutil/trace.go:171","msg":"trace[91534444] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1966; }","duration":"184.152957ms","start":"2026-05-04T18:57:30.024072Z","end":"2026-05-04T18:57:30.208225Z","steps":["trace[91534444] 'agreement among raft nodes before linearized reading'  (duration: 184.027279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.208262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.09759ms","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-05-04T18:57:30.208307Z","caller":"traceutil/trace.go:171","msg":"trace[728906028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1966; }","duration":"121.206237ms","start":"2026-05-04T18:57:30.087091Z","end":"2026-05-04T18:57:30.208297Z","steps":["trace[728906028] 'agreement among raft nodes before linearized reading'  (duration: 121.028746ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.208331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.513671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-04T18:57:30.208369Z","caller":"traceutil/trace.go:171","msg":"trace[1621472452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1966; }","duration":"327.600986ms","start":"2026-05-04T18:57:29.88076Z","end":"2026-05-04T18:57:30.208361Z","steps":["trace[1621472452] 'agreement among raft nodes before linearized reading'  (duration: 327.476568ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.208395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:29.880717Z","time spent":"327.67218ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-04T18:57:30.208642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.203998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:57:30.210339Z","caller":"traceutil/trace.go:171","msg":"trace[1633836978] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1966; }","duration":"474.201439ms","start":"2026-05-04T18:57:29.736119Z","end":"2026-05-04T18:57:30.210321Z","steps":["trace[1633836978] 'agreement among raft nodes before linearized reading'  (duration: 471.958624ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:30.208686Z","caller":"traceutil/trace.go:171","msg":"trace[1240428435] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"218.526519ms","start":"2026-05-04T18:57:29.990149Z","end":"2026-05-04T18:57:30.208675Z","steps":["trace[1240428435] 'process raft request'  (duration: 217.620145ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:30.210418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:29.736104Z","time spent":"474.291474ms","remote":"127.0.0.1:40204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"info","ts":"2026-05-04T18:57:52.39689Z","caller":"traceutil/trace.go:171","msg":"trace[1065718720] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"121.885729ms","start":"2026-05-04T18:57:52.27496Z","end":"2026-05-04T18:57:52.396845Z","steps":["trace[1065718720] 'process raft request'  (duration: 121.649926ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:52.418379Z","caller":"traceutil/trace.go:171","msg":"trace[591387266] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2179; }","duration":"114.018815ms","start":"2026-05-04T18:57:52.304326Z","end":"2026-05-04T18:57:52.418345Z","steps":["trace[591387266] 'read index received'  (duration: 92.229869ms)","trace[591387266] 'applied index is now lower than readState.Index'  (duration: 21.786766ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:57:52.418516Z","caller":"traceutil/trace.go:171","msg":"trace[1200962580] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"135.057399ms","start":"2026-05-04T18:57:52.283414Z","end":"2026-05-04T18:57:52.418471Z","steps":["trace[1200962580] 'process raft request'  (duration: 134.733971ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:52.418777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.429918ms","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-05-04T18:57:52.418874Z","caller":"traceutil/trace.go:171","msg":"trace[142963984] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2102; }","duration":"114.573666ms","start":"2026-05-04T18:57:52.304272Z","end":"2026-05-04T18:57:52.418846Z","steps":["trace[142963984] 'agreement among raft nodes before linearized reading'  (duration: 114.347743ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:52.419601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.224699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-04T18:57:52.419659Z","caller":"traceutil/trace.go:171","msg":"trace[679600848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2102; }","duration":"111.339966ms","start":"2026-05-04T18:57:52.308303Z","end":"2026-05-04T18:57:52.419643Z","steps":["trace[679600848] 'agreement among raft nodes before linearized reading'  (duration: 111.145705ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:52.420072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.860114ms","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-05-04T18:57:52.420194Z","caller":"traceutil/trace.go:171","msg":"trace[550227708] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2102; }","duration":"112.000772ms","start":"2026-05-04T18:57:52.308153Z","end":"2026-05-04T18:57:52.420154Z","steps":["trace[550227708] 'agreement among raft nodes before linearized reading'  (duration: 111.721646ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:52.420309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.5583ms","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-05-04T18:57:52.420714Z","caller":"traceutil/trace.go:171","msg":"trace[682959334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2102; }","duration":"105.923301ms","start":"2026-05-04T18:57:52.314725Z","end":"2026-05-04T18:57:52.420648Z","steps":["trace[682959334] 'agreement among raft nodes before linearized reading'  (duration: 104.357123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:52.677889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.381711ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150841029399523 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2095 > 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-05-04T18:57:52.67822Z","caller":"traceutil/trace.go:171","msg":"trace[223661457] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"254.564304ms","start":"2026-05-04T18:57:52.423623Z","end":"2026-05-04T18:57:52.678187Z","steps":["trace[223661457] 'process raft request'  (duration: 20.78706ms)","trace[223661457] 'compare'  (duration: 233.287436ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:57:52.67835Z","caller":"traceutil/trace.go:171","msg":"trace[915605683] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"253.195966ms","start":"2026-05-04T18:57:52.425121Z","end":"2026-05-04T18:57:52.678317Z","steps":["trace[915605683] 'process raft request'  (duration: 252.987224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:52.678561Z","caller":"traceutil/trace.go:171","msg":"trace[1142944322] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2182; }","duration":"172.484264ms","start":"2026-05-04T18:57:52.506036Z","end":"2026-05-04T18:57:52.678521Z","steps":["trace[1142944322] 'read index received'  (duration: 41.262µs)","trace[1142944322] 'applied index is now lower than readState.Index'  (duration: 172.442022ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:57:52.678567Z","caller":"traceutil/trace.go:171","msg":"trace[1218269134] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"253.360155ms","start":"2026-05-04T18:57:52.425191Z","end":"2026-05-04T18:57:52.678551Z","steps":["trace[1218269134] 'process raft request'  (duration: 253.023656ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:52.678588Z","caller":"traceutil/trace.go:171","msg":"trace[1941643238] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"252.835286ms","start":"2026-05-04T18:57:52.425736Z","end":"2026-05-04T18:57:52.678571Z","steps":["trace[1941643238] 'process raft request'  (duration: 252.740021ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:52.678782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.741419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T18:57:52.678849Z","caller":"traceutil/trace.go:171","msg":"trace[1265192466] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2108; }","duration":"172.834574ms","start":"2026-05-04T18:57:52.50599Z","end":"2026-05-04T18:57:52.678824Z","steps":["trace[1265192466] 'agreement among raft nodes before linearized reading'  (duration: 172.716268ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:52.679313Z","caller":"traceutil/trace.go:171","msg":"trace[474833127] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"254.079926ms","start":"2026-05-04T18:57:52.425219Z","end":"2026-05-04T18:57:52.679299Z","steps":["trace[474833127] 'process raft request'  (duration: 253.066369ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:53.649158Z","caller":"traceutil/trace.go:171","msg":"trace[839333511] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"166.66013ms","start":"2026-05-04T18:57:53.482224Z","end":"2026-05-04T18:57:53.648885Z","steps":["trace[839333511] 'process raft request'  (duration: 166.492109ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.311719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.022369ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150841029399534 > lease_revoke:<id:0db69df4580f931a>","response":"size:28"}
{"level":"info","ts":"2026-05-04T18:57:54.311904Z","caller":"traceutil/trace.go:171","msg":"trace[1716501788] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2188; }","duration":"310.104764ms","start":"2026-05-04T18:57:54.00178Z","end":"2026-05-04T18:57:54.311884Z","steps":["trace[1716501788] 'read index received'  (duration: 117.388µs)","trace[1716501788] 'applied index is now lower than readState.Index'  (duration: 309.985995ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:57:54.312058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.243921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:57:54.312094Z","caller":"traceutil/trace.go:171","msg":"trace[659002075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2109; }","duration":"310.355058ms","start":"2026-05-04T18:57:54.001729Z","end":"2026-05-04T18:57:54.312084Z","steps":["trace[659002075] 'agreement among raft nodes before linearized reading'  (duration: 310.256442ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.312447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:54.00167Z","time spent":"310.76253ms","remote":"127.0.0.1:56432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T18:57:54.312569Z","caller":"traceutil/trace.go:171","msg":"trace[471421978] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"206.470826ms","start":"2026-05-04T18:57:54.105965Z","end":"2026-05-04T18:57:54.312436Z","steps":["trace[471421978] 'process raft request'  (duration: 205.862302ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.801473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.623463ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150841029399539 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2102 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:57:54.801685Z","caller":"traceutil/trace.go:171","msg":"trace[1189455532] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"377.237377ms","start":"2026-05-04T18:57:54.424415Z","end":"2026-05-04T18:57:54.801653Z","steps":["trace[1189455532] 'process raft request'  (duration: 269.99739ms)","trace[1189455532] 'compare'  (duration: 105.84205ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:57:54.801851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:54.424399Z","time spent":"377.377825ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2102 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-04T18:57:54.801877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.407537ms","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-05-04T18:57:54.801919Z","caller":"traceutil/trace.go:171","msg":"trace[1781334371] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2191; }","duration":"372.215266ms","start":"2026-05-04T18:57:54.429459Z","end":"2026-05-04T18:57:54.801674Z","steps":["trace[1781334371] 'read index received'  (duration: 264.919796ms)","trace[1781334371] 'applied index is now lower than readState.Index'  (duration: 107.29304ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:57:54.801958Z","caller":"traceutil/trace.go:171","msg":"trace[1298081171] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2112; }","duration":"372.517983ms","start":"2026-05-04T18:57:54.429425Z","end":"2026-05-04T18:57:54.801943Z","steps":["trace[1298081171] 'agreement among raft nodes before linearized reading'  (duration: 372.334903ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.801996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:54.429413Z","time spent":"372.573777ms","remote":"127.0.0.1:56676","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-05-04T18:57:54.802135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.490607ms","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-05-04T18:57:54.802185Z","caller":"traceutil/trace.go:171","msg":"trace[2034391969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2112; }","duration":"118.579471ms","start":"2026-05-04T18:57:54.683592Z","end":"2026-05-04T18:57:54.802171Z","steps":["trace[2034391969] 'agreement among raft nodes before linearized reading'  (duration: 118.471555ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.802328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.701448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-04T18:57:54.802372Z","caller":"traceutil/trace.go:171","msg":"trace[1230010617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2112; }","duration":"118.788133ms","start":"2026-05-04T18:57:54.683574Z","end":"2026-05-04T18:57:54.802363Z","steps":["trace[1230010617] 'agreement among raft nodes before linearized reading'  (duration: 118.605533ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.802378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.594902ms","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-05-04T18:57:54.802407Z","caller":"traceutil/trace.go:171","msg":"trace[204097859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2112; }","duration":"118.638305ms","start":"2026-05-04T18:57:54.683761Z","end":"2026-05-04T18:57:54.802399Z","steps":["trace[204097859] 'agreement among raft nodes before linearized reading'  (duration: 118.55496ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.802407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.688165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-05-04T18:57:54.802487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.972093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-04T18:57:54.802485Z","caller":"traceutil/trace.go:171","msg":"trace[1082930760] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2112; }","duration":"369.814212ms","start":"2026-05-04T18:57:54.432656Z","end":"2026-05-04T18:57:54.80247Z","steps":["trace[1082930760] 'agreement among raft nodes before linearized reading'  (duration: 369.42684ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:54.802511Z","caller":"traceutil/trace.go:171","msg":"trace[2000683058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2112; }","duration":"119.073239ms","start":"2026-05-04T18:57:54.683432Z","end":"2026-05-04T18:57:54.802505Z","steps":["trace[2000683058] 'agreement among raft nodes before linearized reading'  (duration: 119.008855ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:57:54.802528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.777433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-04T18:57:54.802556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:57:54.432625Z","time spent":"369.893416ms","remote":"127.0.0.1:42202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-04T18:57:54.802565Z","caller":"traceutil/trace.go:171","msg":"trace[1684507263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2112; }","duration":"118.838225ms","start":"2026-05-04T18:57:54.683717Z","end":"2026-05-04T18:57:54.802556Z","steps":["trace[1684507263] 'agreement among raft nodes before linearized reading'  (duration: 118.753151ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:23.273998Z","caller":"traceutil/trace.go:171","msg":"trace[790061848] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"117.447667ms","start":"2026-05-04T18:59:23.156525Z","end":"2026-05-04T18:59:23.273973Z","steps":["trace[790061848] 'process raft request'  (duration: 117.147784ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:23.274495Z","caller":"traceutil/trace.go:171","msg":"trace[1061192054] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"115.222361ms","start":"2026-05-04T18:59:23.159231Z","end":"2026-05-04T18:59:23.274453Z","steps":["trace[1061192054] 'process raft request'  (duration: 114.985691ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.462571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.006035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150841029401055 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18ac71dd6fd5df25\" mod_revision:2703 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18ac71dd6fd5df25\" value_size:690 lease:988150841029400913 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18ac71dd6fd5df25\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:59:29.462747Z","caller":"traceutil/trace.go:171","msg":"trace[554105503] linearizableReadLoop","detail":"{readStateIndex:2828; appliedIndex:2826; }","duration":"460.704178ms","start":"2026-05-04T18:59:29.002031Z","end":"2026-05-04T18:59:29.462735Z","steps":["trace[554105503] 'read index received'  (duration: 166.362749ms)","trace[554105503] 'applied index is now lower than readState.Index'  (duration: 294.340589ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:29.462772Z","caller":"traceutil/trace.go:171","msg":"trace[414475728] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"674.83476ms","start":"2026-05-04T18:59:28.787906Z","end":"2026-05-04T18:59:29.462741Z","steps":["trace[414475728] 'process raft request'  (duration: 380.574794ms)","trace[414475728] 'compare'  (duration: 293.889091ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:29.462804Z","caller":"traceutil/trace.go:171","msg":"trace[110323455] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"621.897857ms","start":"2026-05-04T18:59:28.840862Z","end":"2026-05-04T18:59:29.46276Z","steps":["trace[110323455] 'process raft request'  (duration: 621.804033ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.462904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:59:28.78788Z","time spent":"674.954535ms","remote":"127.0.0.1:56492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":764,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18ac71dd6fd5df25\" mod_revision:2703 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18ac71dd6fd5df25\" value_size:690 lease:988150841029400913 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18ac71dd6fd5df25\" > >"}
{"level":"warn","ts":"2026-05-04T18:59:29.462907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:59:28.840835Z","time spent":"622.023082ms","remote":"127.0.0.1:56472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.19\" mod_revision:2673 > success:<request_put:<key:\"/registry/masterleases/199.204.45.19\" value_size:66 lease:988150841029401053 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.19\" > >"}
{"level":"warn","ts":"2026-05-04T18:59:29.462994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.966229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:59:29.463054Z","caller":"traceutil/trace.go:171","msg":"trace[1010712609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2726; }","duration":"461.065943ms","start":"2026-05-04T18:59:29.001977Z","end":"2026-05-04T18:59:29.463043Z","steps":["trace[1010712609] 'agreement among raft nodes before linearized reading'  (duration: 460.928867ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.463079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:59:29.001944Z","time spent":"461.128726ms","remote":"127.0.0.1:56432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T18:59:29.487041Z","caller":"traceutil/trace.go:171","msg":"trace[567572729] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"194.975514ms","start":"2026-05-04T18:59:29.292048Z","end":"2026-05-04T18:59:29.487023Z","steps":["trace[567572729] 'process raft request'  (duration: 194.594688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.487388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.574917ms","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-05-04T18:59:29.487438Z","caller":"traceutil/trace.go:171","msg":"trace[1409731596] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2728; }","duration":"182.65374ms","start":"2026-05-04T18:59:29.304773Z","end":"2026-05-04T18:59:29.487427Z","steps":["trace[1409731596] 'agreement among raft nodes before linearized reading'  (duration: 182.498603ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.487433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.69002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-04T18:59:29.487477Z","caller":"traceutil/trace.go:171","msg":"trace[859267646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2728; }","duration":"185.763243ms","start":"2026-05-04T18:59:29.301702Z","end":"2026-05-04T18:59:29.487465Z","steps":["trace[859267646] 'agreement among raft nodes before linearized reading'  (duration: 185.643248ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.487493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.11192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-04T18:59:29.487551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.303118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T18:59:29.48771Z","caller":"traceutil/trace.go:171","msg":"trace[79014895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2728; }","duration":"179.529618ms","start":"2026-05-04T18:59:29.308141Z","end":"2026-05-04T18:59:29.487671Z","steps":["trace[79014895] 'agreement among raft nodes before linearized reading'  (duration: 179.173013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.487743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.476248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-04T18:59:29.487771Z","caller":"traceutil/trace.go:171","msg":"trace[1824093935] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"188.826484ms","start":"2026-05-04T18:59:29.298402Z","end":"2026-05-04T18:59:29.487228Z","steps":["trace[1824093935] 'process raft request'  (duration: 188.347213ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:29.487788Z","caller":"traceutil/trace.go:171","msg":"trace[537210003] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2728; }","duration":"184.553722ms","start":"2026-05-04T18:59:29.303225Z","end":"2026-05-04T18:59:29.487779Z","steps":["trace[537210003] 'agreement among raft nodes before linearized reading'  (duration: 184.447907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:29.487612Z","caller":"traceutil/trace.go:171","msg":"trace[1721651174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2728; }","duration":"183.238025ms","start":"2026-05-04T18:59:29.304335Z","end":"2026-05-04T18:59:29.487573Z","steps":["trace[1721651174] 'agreement among raft nodes before linearized reading'  (duration: 182.995055ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:29.488127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.572734ms","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-05-04T18:59:29.489121Z","caller":"traceutil/trace.go:171","msg":"trace[978840365] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2728; }","duration":"186.559736ms","start":"2026-05-04T18:59:29.302522Z","end":"2026-05-04T18:59:29.489082Z","steps":["trace[978840365] 'agreement among raft nodes before linearized reading'  (duration: 184.725328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:49.731683Z","caller":"traceutil/trace.go:171","msg":"trace[503801219] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"102.907994ms","start":"2026-05-04T18:59:49.628721Z","end":"2026-05-04T18:59:49.731629Z","steps":["trace[503801219] 'process raft request'  (duration: 100.673605ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:02:06.223108Z","caller":"traceutil/trace.go:171","msg":"trace[863579539] transaction","detail":"{read_only:false; response_revision:3645; number_of_response:1; }","duration":"161.217143ms","start":"2026-05-04T19:02:06.061862Z","end":"2026-05-04T19:02:06.223079Z","steps":["trace[863579539] 'process raft request'  (duration: 161.014308ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:02:06.225957Z","caller":"traceutil/trace.go:171","msg":"trace[941430443] transaction","detail":"{read_only:false; response_revision:3646; number_of_response:1; }","duration":"162.900191ms","start":"2026-05-04T19:02:06.06303Z","end":"2026-05-04T19:02:06.22593Z","steps":["trace[941430443] 'process raft request'  (duration: 162.774228ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:02:06.37489Z","caller":"traceutil/trace.go:171","msg":"trace[464343805] transaction","detail":"{read_only:false; response_revision:3647; number_of_response:1; }","duration":"112.167637ms","start":"2026-05-04T19:02:06.262688Z","end":"2026-05-04T19:02:06.374856Z","steps":["trace[464343805] 'process raft request'  (duration: 104.107516ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:02:06.37496Z","caller":"traceutil/trace.go:171","msg":"trace[935653763] linearizableReadLoop","detail":"{readStateIndex:3784; appliedIndex:3783; }","duration":"111.166878ms","start":"2026-05-04T19:02:06.263746Z","end":"2026-05-04T19:02:06.374913Z","steps":["trace[935653763] 'read index received'  (duration: 103.028835ms)","trace[935653763] 'applied index is now lower than readState.Index'  (duration: 8.134933ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:02:06.375Z","caller":"traceutil/trace.go:171","msg":"trace[1735520903] transaction","detail":"{read_only:false; response_revision:3648; number_of_response:1; }","duration":"109.13693ms","start":"2026-05-04T19:02:06.265841Z","end":"2026-05-04T19:02:06.374978Z","steps":["trace[1735520903] 'process raft request'  (duration: 109.015997ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:02:06.374968Z","caller":"traceutil/trace.go:171","msg":"trace[1655120522] transaction","detail":"{read_only:false; response_revision:3649; number_of_response:1; }","duration":"108.418289ms","start":"2026-05-04T19:02:06.266525Z","end":"2026-05-04T19:02:06.374943Z","steps":["trace[1655120522] 'process raft request'  (duration: 108.375688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:02:06.375293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.450256ms","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-05-04T19:02:06.375356Z","caller":"traceutil/trace.go:171","msg":"trace[710439318] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3649; }","duration":"111.523318ms","start":"2026-05-04T19:02:06.263805Z","end":"2026-05-04T19:02:06.375328Z","steps":["trace[710439318] 'agreement among raft nodes before linearized reading'  (duration: 111.355623ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:02:06.375821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.062513ms","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-05-04T19:02:06.375898Z","caller":"traceutil/trace.go:171","msg":"trace[8718145] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3649; }","duration":"112.160816ms","start":"2026-05-04T19:02:06.263709Z","end":"2026-05-04T19:02:06.37587Z","steps":["trace[8718145] 'agreement among raft nodes before linearized reading'  (duration: 111.382684ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:10.180143Z","caller":"traceutil/trace.go:171","msg":"trace[1207737115] transaction","detail":"{read_only:false; response_revision:4455; number_of_response:1; }","duration":"186.765895ms","start":"2026-05-04T19:03:09.99336Z","end":"2026-05-04T19:03:10.180126Z","steps":["trace[1207737115] 'process raft request'  (duration: 186.669102ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:10.184094Z","caller":"traceutil/trace.go:171","msg":"trace[263810998] linearizableReadLoop","detail":"{readStateIndex:4627; appliedIndex:4626; }","duration":"184.981241ms","start":"2026-05-04T19:03:09.999079Z","end":"2026-05-04T19:03:10.18406Z","steps":["trace[263810998] 'read index received'  (duration: 181.430121ms)","trace[263810998] 'applied index is now lower than readState.Index'  (duration: 3.54892ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T19:03:10.184333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.230897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T19:03:10.184384Z","caller":"traceutil/trace.go:171","msg":"trace[1215424557] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:0; response_revision:4456; }","duration":"185.308819ms","start":"2026-05-04T19:03:09.999056Z","end":"2026-05-04T19:03:10.184365Z","steps":["trace[1215424557] 'agreement among raft nodes before linearized reading'  (duration: 185.113534ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:10.184528Z","caller":"traceutil/trace.go:171","msg":"trace[1093425195] transaction","detail":"{read_only:false; response_revision:4456; number_of_response:1; }","duration":"189.276209ms","start":"2026-05-04T19:03:09.995223Z","end":"2026-05-04T19:03:10.1845Z","steps":["trace[1093425195] 'process raft request'  (duration: 187.925745ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:15.307308Z","caller":"traceutil/trace.go:171","msg":"trace[1310900826] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"129.527948ms","start":"2026-05-04T19:03:15.177755Z","end":"2026-05-04T19:03:15.307283Z","steps":["trace[1310900826] 'process raft request'  (duration: 129.406505ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:15.479412Z","caller":"traceutil/trace.go:171","msg":"trace[1051713992] linearizableReadLoop","detail":"{readStateIndex:4791; appliedIndex:4790; }","duration":"114.676579ms","start":"2026-05-04T19:03:15.364711Z","end":"2026-05-04T19:03:15.479388Z","steps":["trace[1051713992] 'read index received'  (duration: 35.508483ms)","trace[1051713992] 'applied index is now lower than readState.Index'  (duration: 79.166836ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T19:03:15.479638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.87944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11453"}
{"level":"info","ts":"2026-05-04T19:03:15.479699Z","caller":"traceutil/trace.go:171","msg":"trace[1853672222] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4615; }","duration":"132.975883ms","start":"2026-05-04T19:03:15.346706Z","end":"2026-05-04T19:03:15.479682Z","steps":["trace[1853672222] 'agreement among raft nodes before linearized reading'  (duration: 132.795929ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:15.479816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.247305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-05-04T19:03:15.479918Z","caller":"traceutil/trace.go:171","msg":"trace[1120066619] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4615; }","duration":"130.362247ms","start":"2026-05-04T19:03:15.349495Z","end":"2026-05-04T19:03:15.479858Z","steps":["trace[1120066619] 'agreement among raft nodes before linearized reading'  (duration: 129.934257ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:15.479799Z","caller":"traceutil/trace.go:171","msg":"trace[1491471512] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"132.522832ms","start":"2026-05-04T19:03:15.34695Z","end":"2026-05-04T19:03:15.479473Z","steps":["trace[1491471512] 'process raft request'  (duration: 53.260193ms)","trace[1491471512] 'compare'  (duration: 79.044404ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:03:15.480713Z","caller":"traceutil/trace.go:171","msg":"trace[1588989767] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"102.237889ms","start":"2026-05-04T19:03:15.37842Z","end":"2026-05-04T19:03:15.480658Z","steps":["trace[1588989767] 'process raft request'  (duration: 102.095296ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:15.480758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.830312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-vkvks-tls-chqfm\" ","response":"range_response_count:1 size:2629"}
{"level":"info","ts":"2026-05-04T19:03:15.480807Z","caller":"traceutil/trace.go:171","msg":"trace[1636938561] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-vkvks-tls-chqfm; range_end:; response_count:1; response_revision:4617; }","duration":"108.911614ms","start":"2026-05-04T19:03:15.371881Z","end":"2026-05-04T19:03:15.480792Z","steps":["trace[1636938561] 'agreement among raft nodes before linearized reading'  (duration: 108.686339ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:15.481111Z","caller":"traceutil/trace.go:171","msg":"trace[321769021] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"108.811053ms","start":"2026-05-04T19:03:15.372283Z","end":"2026-05-04T19:03:15.481094Z","steps":["trace[321769021] 'process raft request'  (duration: 108.172046ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:15.481216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.882826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-vkvks-tls\" ","response":"range_response_count:1 size:4431"}
{"level":"info","ts":"2026-05-04T19:03:15.481271Z","caller":"traceutil/trace.go:171","msg":"trace[2018750308] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-vkvks-tls; range_end:; response_count:1; response_revision:4617; }","duration":"106.954928ms","start":"2026-05-04T19:03:15.374304Z","end":"2026-05-04T19:03:15.481259Z","steps":["trace[2018750308] 'agreement among raft nodes before linearized reading'  (duration: 106.824315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:15.481547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.535891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-05-04T19:03:15.481655Z","caller":"traceutil/trace.go:171","msg":"trace[1112600179] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4617; }","duration":"109.663884ms","start":"2026-05-04T19:03:15.371975Z","end":"2026-05-04T19:03:15.481639Z","steps":["trace[1112600179] 'agreement among raft nodes before linearized reading'  (duration: 109.4774ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:21.687735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.522227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-19b6af2e-2f6a-413b-bbcc-b7c682194de9\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-05-04T19:03:21.687903Z","caller":"traceutil/trace.go:171","msg":"trace[828719212] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-19b6af2e-2f6a-413b-bbcc-b7c682194de9; range_end:; response_count:1; response_revision:4739; }","duration":"124.680411ms","start":"2026-05-04T19:03:21.563129Z","end":"2026-05-04T19:03:21.687809Z","steps":["trace[828719212] 'range keys from in-memory index tree'  (duration: 124.261191ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:22.681413Z","caller":"traceutil/trace.go:171","msg":"trace[1140924921] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"155.325997ms","start":"2026-05-04T19:03:22.526055Z","end":"2026-05-04T19:03:22.681381Z","steps":["trace[1140924921] 'process raft request'  (duration: 70.15795ms)","trace[1140924921] 'compare'  (duration: 85.055165ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:03:22.68204Z","caller":"traceutil/trace.go:171","msg":"trace[865332481] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"155.016879ms","start":"2026-05-04T19:03:22.526997Z","end":"2026-05-04T19:03:22.682014Z","steps":["trace[865332481] 'process raft request'  (duration: 154.914946ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:22.682202Z","caller":"traceutil/trace.go:171","msg":"trace[513369429] linearizableReadLoop","detail":"{readStateIndex:4924; appliedIndex:4921; }","duration":"139.075928ms","start":"2026-05-04T19:03:22.543105Z","end":"2026-05-04T19:03:22.68218Z","steps":["trace[513369429] 'read index received'  (duration: 53.203923ms)","trace[513369429] 'applied index is now lower than readState.Index'  (duration: 85.870695ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:03:22.682256Z","caller":"traceutil/trace.go:171","msg":"trace[409691168] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"141.60224ms","start":"2026-05-04T19:03:22.540624Z","end":"2026-05-04T19:03:22.682226Z","steps":["trace[409691168] 'process raft request'  (duration: 141.356674ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:22.682407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.283173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-05-04T19:03:22.682455Z","caller":"traceutil/trace.go:171","msg":"trace[545070400] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4746; }","duration":"139.369306ms","start":"2026-05-04T19:03:22.543074Z","end":"2026-05-04T19:03:22.682443Z","steps":["trace[545070400] 'agreement among raft nodes before linearized reading'  (duration: 139.194592ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:25.469798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.851716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-05-04T19:03:25.470009Z","caller":"traceutil/trace.go:171","msg":"trace[1463446195] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4791; }","duration":"316.134754ms","start":"2026-05-04T19:03:25.153852Z","end":"2026-05-04T19:03:25.469986Z","steps":["trace[1463446195] 'range keys from in-memory index tree'  (duration: 315.63875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:25.470103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:25.15382Z","time spent":"316.263886ms","remote":"127.0.0.1:53656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3266,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "}
{"level":"info","ts":"2026-05-04T19:03:35.179423Z","caller":"traceutil/trace.go:171","msg":"trace[1141556275] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"437.883872ms","start":"2026-05-04T19:03:34.741513Z","end":"2026-05-04T19:03:35.179397Z","steps":["trace[1141556275] 'process raft request'  (duration: 437.732609ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.179587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.741489Z","time spent":"438.016176ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4895 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-04T19:03:35.744703Z","caller":"traceutil/trace.go:171","msg":"trace[515677690] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5092; }","duration":"865.680885ms","start":"2026-05-04T19:03:34.879003Z","end":"2026-05-04T19:03:35.744684Z","steps":["trace[515677690] 'read index received'  (duration: 300.363308ms)","trace[515677690] 'applied index is now lower than readState.Index'  (duration: 565.316627ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:03:35.744802Z","caller":"traceutil/trace.go:171","msg":"trace[1987862983] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"703.631274ms","start":"2026-05-04T19:03:35.041162Z","end":"2026-05-04T19:03:35.744793Z","steps":["trace[1987862983] 'process raft request'  (duration: 703.486311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:35.744778Z","caller":"traceutil/trace.go:171","msg":"trace[1458249575] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"1.001207001s","start":"2026-05-04T19:03:34.743535Z","end":"2026-05-04T19:03:35.744742Z","steps":["trace[1458249575] 'process raft request'  (duration: 1.000959525s)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.744901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:35.041136Z","time spent":"703.690346ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4903 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T19:03:35.74495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.743519Z","time spent":"1.001341075s","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4896 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-04T19:03:35.745087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.222154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-04T19:03:35.745179Z","caller":"traceutil/trace.go:171","msg":"trace[419172274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4911; }","duration":"865.371748ms","start":"2026-05-04T19:03:34.879787Z","end":"2026-05-04T19:03:35.745159Z","steps":["trace[419172274] 'agreement among raft nodes before linearized reading'  (duration: 865.074471ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.638513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"}
{"level":"warn","ts":"2026-05-04T19:03:35.745233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.879764Z","time spent":"865.45908ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-04T19:03:35.745268Z","caller":"traceutil/trace.go:171","msg":"trace[301810230] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4911; }","duration":"562.718115ms","start":"2026-05-04T19:03:35.182539Z","end":"2026-05-04T19:03:35.745257Z","steps":["trace[301810230] 'agreement among raft nodes before linearized reading'  (duration: 562.550201ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:35.182518Z","time spent":"562.778596ms","remote":"127.0.0.1:56602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10414,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-04T19:03:35.745317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.734179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-05-04T19:03:35.745349Z","caller":"traceutil/trace.go:171","msg":"trace[54207150] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4911; }","duration":"251.813922ms","start":"2026-05-04T19:03:35.493526Z","end":"2026-05-04T19:03:35.74534Z","steps":["trace[54207150] 'agreement among raft nodes before linearized reading'  (duration: 251.708439ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.199807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T19:03:35.745487Z","caller":"traceutil/trace.go:171","msg":"trace[536985421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4911; }","duration":"742.280869ms","start":"2026-05-04T19:03:35.003196Z","end":"2026-05-04T19:03:35.745477Z","steps":["trace[536985421] 'agreement among raft nodes before linearized reading'  (duration: 742.186107ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:35.003167Z","time spent":"742.346681ms","remote":"127.0.0.1:56432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T19:03:35.745548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.553106ms","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-05-04T19:03:35.745574Z","caller":"traceutil/trace.go:171","msg":"trace[1664966829] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4911; }","duration":"866.610087ms","start":"2026-05-04T19:03:34.878958Z","end":"2026-05-04T19:03:35.745568Z","steps":["trace[1664966829] 'agreement among raft nodes before linearized reading'  (duration: 866.539105ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.878907Z","time spent":"866.681669ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-04T19:03:35.74561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.044877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T19:03:35.745653Z","caller":"traceutil/trace.go:171","msg":"trace[220148594] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4911; }","duration":"275.117898ms","start":"2026-05-04T19:03:35.470524Z","end":"2026-05-04T19:03:35.745642Z","steps":["trace[220148594] 'agreement among raft nodes before linearized reading'  (duration: 275.051256ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.69814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-05-04T19:03:35.745814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.591365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-04T19:03:35.745829Z","caller":"traceutil/trace.go:171","msg":"trace[287462605] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4911; }","duration":"864.770023ms","start":"2026-05-04T19:03:34.881053Z","end":"2026-05-04T19:03:35.745823Z","steps":["trace[287462605] 'agreement among raft nodes before linearized reading'  (duration: 864.697401ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.745849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.881026Z","time spent":"864.818724ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-04T19:03:35.745878Z","caller":"traceutil/trace.go:171","msg":"trace[1550472465] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4911; }","duration":"863.666266ms","start":"2026-05-04T19:03:34.8822Z","end":"2026-05-04T19:03:35.745866Z","steps":["trace[1550472465] 'agreement among raft nodes before linearized reading'  (duration: 863.528023ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.74591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.882194Z","time spent":"863.709158ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T19:03:35.746109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.166913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-04T19:03:35.746149Z","caller":"traceutil/trace.go:171","msg":"trace[1054264914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4911; }","duration":"865.228145ms","start":"2026-05-04T19:03:34.880911Z","end":"2026-05-04T19:03:35.74614Z","steps":["trace[1054264914] 'agreement among raft nodes before linearized reading'  (duration: 865.122282ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.746184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.880902Z","time spent":"865.275895ms","remote":"127.0.0.1:56676","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-05-04T19:03:35.74623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.30942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-05-04T19:03:35.746199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.762213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T19:03:35.746261Z","caller":"traceutil/trace.go:171","msg":"trace[809529543] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4911; }","duration":"494.34128ms","start":"2026-05-04T19:03:35.251913Z","end":"2026-05-04T19:03:35.746254Z","steps":["trace[809529543] 'agreement among raft nodes before linearized reading'  (duration: 493.818847ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.746287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:35.251872Z","time spent":"494.411052ms","remote":"127.0.0.1:56578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"info","ts":"2026-05-04T19:03:35.746312Z","caller":"traceutil/trace.go:171","msg":"trace[1640802364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4911; }","duration":"864.903377ms","start":"2026-05-04T19:03:34.881376Z","end":"2026-05-04T19:03:35.74628Z","steps":["trace[1640802364] 'agreement among raft nodes before linearized reading'  (duration: 864.383374ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:03:35.746384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:03:34.881368Z","time spent":"864.998719ms","remote":"127.0.0.1:56676","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-05-04T19:03:35.897082Z","caller":"traceutil/trace.go:171","msg":"trace[406306534] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"143.596822ms","start":"2026-05-04T19:03:35.753366Z","end":"2026-05-04T19:03:35.896963Z","steps":["trace[406306534] 'process raft request'  (duration: 68.095888ms)","trace[406306534] 'compare'  (duration: 75.3016ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:03:35.897401Z","caller":"traceutil/trace.go:171","msg":"trace[414945469] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"143.747837ms","start":"2026-05-04T19:03:35.753628Z","end":"2026-05-04T19:03:35.897376Z","steps":["trace[414945469] 'process raft request'  (duration: 143.286765ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:35.897645Z","caller":"traceutil/trace.go:171","msg":"trace[1629431856] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"143.946032ms","start":"2026-05-04T19:03:35.753687Z","end":"2026-05-04T19:03:35.897633Z","steps":["trace[1629431856] 'process raft request'  (duration: 143.594994ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:35.897762Z","caller":"traceutil/trace.go:171","msg":"trace[1014474290] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"138.280486ms","start":"2026-05-04T19:03:35.759469Z","end":"2026-05-04T19:03:35.897749Z","steps":["trace[1014474290] 'process raft request'  (duration: 138.233655ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:35.897832Z","caller":"traceutil/trace.go:171","msg":"trace[789055781] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"140.901869ms","start":"2026-05-04T19:03:35.756901Z","end":"2026-05-04T19:03:35.897803Z","steps":["trace[789055781] 'process raft request'  (duration: 140.654943ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:35.898008Z","caller":"traceutil/trace.go:171","msg":"trace[1882111159] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"141.066863ms","start":"2026-05-04T19:03:35.75693Z","end":"2026-05-04T19:03:35.897996Z","steps":["trace[1882111159] 'process raft request'  (duration: 140.706314ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:35.898183Z","caller":"traceutil/trace.go:171","msg":"trace[1819083543] linearizableReadLoop","detail":"{readStateIndex:5097; appliedIndex:5095; }","duration":"144.683129ms","start":"2026-05-04T19:03:35.753487Z","end":"2026-05-04T19:03:35.89817Z","steps":["trace[1819083543] 'read index received'  (duration: 1.989087ms)","trace[1819083543] 'applied index is now lower than readState.Index'  (duration: 142.692422ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T19:03:35.898334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.826992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-19b6af2e-2f6a-413b-bbcc-b7c682194de9\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-04T19:03:35.89837Z","caller":"traceutil/trace.go:171","msg":"trace[322022765] range","detail":"{range_begin:/registry/persistentvolumes/pvc-19b6af2e-2f6a-413b-bbcc-b7c682194de9; range_end:; response_count:1; response_revision:4918; }","duration":"144.895384ms","start":"2026-05-04T19:03:35.753465Z","end":"2026-05-04T19:03:35.89836Z","steps":["trace[322022765] 'agreement among raft nodes before linearized reading'  (duration: 144.756551ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:36.177938Z","caller":"traceutil/trace.go:171","msg":"trace[500588833] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"209.217826ms","start":"2026-05-04T19:03:35.968691Z","end":"2026-05-04T19:03:36.177909Z","steps":["trace[500588833] 'process raft request'  (duration: 168.040123ms)","trace[500588833] 'compare'  (duration: 40.997829ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:03:36.67268Z","caller":"traceutil/trace.go:171","msg":"trace[1267659057] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"128.494977ms","start":"2026-05-04T19:03:36.544159Z","end":"2026-05-04T19:03:36.672654Z","steps":["trace[1267659057] 'process raft request'  (duration: 128.235211ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:36.672905Z","caller":"traceutil/trace.go:171","msg":"trace[2126738990] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"124.297596ms","start":"2026-05-04T19:03:36.548581Z","end":"2026-05-04T19:03:36.672879Z","steps":["trace[2126738990] 'process raft request'  (duration: 124.093091ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:03:36.672881Z","caller":"traceutil/trace.go:171","msg":"trace[40149215] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"128.023225ms","start":"2026-05-04T19:03:36.544838Z","end":"2026-05-04T19:03:36.672861Z","steps":["trace[40149215] 'process raft request'  (duration: 127.685357ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:04:06.358209Z","caller":"traceutil/trace.go:171","msg":"trace[495889702] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"256.373304ms","start":"2026-05-04T19:04:06.101811Z","end":"2026-05-04T19:04:06.358184Z","steps":["trace[495889702] 'process raft request'  (duration: 256.19444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:04:06.358375Z","caller":"traceutil/trace.go:171","msg":"trace[1328723251] linearizableReadLoop","detail":"{readStateIndex:5407; appliedIndex:5405; }","duration":"240.001975ms","start":"2026-05-04T19:04:06.118343Z","end":"2026-05-04T19:04:06.358345Z","steps":["trace[1328723251] 'read index received'  (duration: 239.566435ms)","trace[1328723251] 'applied index is now lower than readState.Index'  (duration: 420.079µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:04:06.35849Z","caller":"traceutil/trace.go:171","msg":"trace[1840977457] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"256.206651ms","start":"2026-05-04T19:04:06.102219Z","end":"2026-05-04T19:04:06.358426Z","steps":["trace[1840977457] 'process raft request'  (duration: 255.923344ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:04:06.358599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.248811ms","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-05-04T19:04:06.358672Z","caller":"traceutil/trace.go:171","msg":"trace[593146316] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5216; }","duration":"240.375584ms","start":"2026-05-04T19:04:06.118285Z","end":"2026-05-04T19:04:06.358661Z","steps":["trace[593146316] 'agreement among raft nodes before linearized reading'  (duration: 240.163589ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:04:07.999845Z","caller":"traceutil/trace.go:171","msg":"trace[615795572] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"114.884493ms","start":"2026-05-04T19:04:07.884922Z","end":"2026-05-04T19:04:07.999807Z","steps":["trace[615795572] 'process raft request'  (duration: 76.732701ms)","trace[615795572] 'compare'  (duration: 37.955107ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:05:05.928479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925}
{"level":"info","ts":"2026-05-04T19:05:06.040181Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"110.403164ms","hash":2899140349,"current-db-size-bytes":52830208,"current-db-size":"53 MB","current-db-size-in-use-bytes":29356032,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-04T19:05:06.04023Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2899140349,"revision":2925,"compact-revision":-1}
{"level":"info","ts":"2026-05-04T19:08:12.013605Z","caller":"traceutil/trace.go:171","msg":"trace[388067511] transaction","detail":"{read_only:false; response_revision:6884; number_of_response:1; }","duration":"281.680675ms","start":"2026-05-04T19:08:11.731904Z","end":"2026-05-04T19:08:12.013585Z","steps":["trace[388067511] 'process raft request'  (duration: 281.543383ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:08:12.015627Z","caller":"traceutil/trace.go:171","msg":"trace[1273801416] transaction","detail":"{read_only:false; response_revision:6885; number_of_response:1; }","duration":"281.728317ms","start":"2026-05-04T19:08:11.733888Z","end":"2026-05-04T19:08:12.015616Z","steps":["trace[1273801416] 'process raft request'  (duration: 281.625185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:08:12.016004Z","caller":"traceutil/trace.go:171","msg":"trace[1997850309] transaction","detail":"{read_only:false; response_revision:6886; number_of_response:1; }","duration":"279.442888ms","start":"2026-05-04T19:08:11.73653Z","end":"2026-05-04T19:08:12.015972Z","steps":["trace[1997850309] 'process raft request'  (duration: 279.046912ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:09:45.605182Z","caller":"traceutil/trace.go:171","msg":"trace[100562948] linearizableReadLoop","detail":"{readStateIndex:7623; appliedIndex:7622; }","duration":"434.579437ms","start":"2026-05-04T19:09:45.170571Z","end":"2026-05-04T19:09:45.60515Z","steps":["trace[100562948] 'read index received'  (duration: 434.388575ms)","trace[100562948] 'applied index is now lower than readState.Index'  (duration: 189.782µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T19:09:45.605361Z","caller":"traceutil/trace.go:171","msg":"trace[1402765958] transaction","detail":"{read_only:false; response_revision:7354; number_of_response:1; }","duration":"452.005991ms","start":"2026-05-04T19:09:45.153308Z","end":"2026-05-04T19:09:45.605314Z","steps":["trace[1402765958] 'process raft request'  (duration: 451.632705ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:09:45.605519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.931242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/rabbitmq-cluster-operator-openstack\" ","response":"range_response_count:1 size:1271"}
{"level":"info","ts":"2026-05-04T19:09:45.605575Z","caller":"traceutil/trace.go:171","msg":"trace[1459636938] range","detail":"{range_begin:/registry/clusterrolebindings/rabbitmq-cluster-operator-openstack; range_end:; response_count:1; response_revision:7354; }","duration":"435.066834ms","start":"2026-05-04T19:09:45.170491Z","end":"2026-05-04T19:09:45.605558Z","steps":["trace[1459636938] 'agreement among raft nodes before linearized reading'  (duration: 434.831421ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:09:45.605638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:09:45.170457Z","time spent":"435.153325ms","remote":"127.0.0.1:56754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1294,"request content":"key:\"/registry/clusterrolebindings/rabbitmq-cluster-operator-openstack\" "}
{"level":"warn","ts":"2026-05-04T19:09:45.605828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:09:45.153275Z","time spent":"452.195344ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:7345 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-04T19:09:45.67265Z","caller":"traceutil/trace.go:171","msg":"trace[913685110] transaction","detail":"{read_only:false; response_revision:7355; number_of_response:1; }","duration":"472.827087ms","start":"2026-05-04T19:09:45.199804Z","end":"2026-05-04T19:09:45.672631Z","steps":["trace[913685110] 'process raft request'  (duration: 472.464992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:09:45.672773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:09:45.199783Z","time spent":"472.923758ms","remote":"127.0.0.1:56676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:7346 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T19:09:45.67307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.079643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:resourcequota-controller\" ","response":"range_response_count:1 size:700"}
{"level":"info","ts":"2026-05-04T19:09:45.673185Z","caller":"traceutil/trace.go:171","msg":"trace[1717752075] range","detail":"{range_begin:/registry/clusterroles/system:controller:resourcequota-controller; range_end:; response_count:1; response_revision:7355; }","duration":"456.256506ms","start":"2026-05-04T19:09:45.216902Z","end":"2026-05-04T19:09:45.673159Z","steps":["trace[1717752075] 'agreement among raft nodes before linearized reading'  (duration: 456.032733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T19:09:45.67323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T19:09:45.216876Z","time spent":"456.343917ms","remote":"127.0.0.1:56750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":723,"request content":"key:\"/registry/clusterroles/system:controller:resourcequota-controller\" "}
{"level":"info","ts":"2026-05-04T19:10:05.935485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5660}
{"level":"info","ts":"2026-05-04T19:10:06.025197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5660,"took":"87.911064ms","hash":412100899,"current-db-size-bytes":52830208,"current-db-size":"53 MB","current-db-size-in-use-bytes":18309120,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-04T19:10:06.025262Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":412100899,"revision":5660,"compact-revision":2925}