{"level":"warn","ts":"2026-05-06T14:09:09.13056Z","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-06T14:09:09.130694Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-06T14:09:09.130778Z","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-06T14:09:09.130788Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]}
{"level":"info","ts":"2026-05-06T14:09:09.13081Z","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-06T14:09:09.131528Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]}
{"level":"info","ts":"2026-05-06T14:09:09.131604Z","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.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-06T14:09:09.138113Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.311017ms"}
{"level":"info","ts":"2026-05-06T14:09:09.146917Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"}
{"level":"info","ts":"2026-05-06T14:09:09.147047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-06T14:09:09.14709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"}
{"level":"info","ts":"2026-05-06T14:09:09.147118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-06T14:09:09.147135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"}
{"level":"info","ts":"2026-05-06T14:09:09.147194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"}
{"level":"warn","ts":"2026-05-06T14:09:09.155614Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-06T14:09:09.156893Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-06T14:09:09.158232Z","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-06T14:09:09.160569Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-06T14:09:09.163227Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-06T14:09:09.163225Z","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-06T14:09:09.163332Z","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-06T14:09:09.16335Z","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-06T14:09:09.16407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"}
{"level":"info","ts":"2026-05-06T14:09:09.170193Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]}
{"level":"info","ts":"2026-05-06T14:09:09.171226Z","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-06T14:09:09.17148Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-06T14:09:09.171516Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-06T14:09:09.17261Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"}
{"level":"info","ts":"2026-05-06T14:09:09.172643Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"}
{"level":"info","ts":"2026-05-06T14:09:09.3474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-06T14:09:09.347457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-06T14:09:09.347476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"}
{"level":"info","ts":"2026-05-06T14:09:09.347491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"}
{"level":"info","ts":"2026-05-06T14:09:09.347499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"}
{"level":"info","ts":"2026-05-06T14:09:09.347511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"}
{"level":"info","ts":"2026-05-06T14:09:09.347531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"}
{"level":"info","ts":"2026-05-06T14:09:09.348575Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-06T14:09:09.349727Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-06T14:09:09.349774Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-06T14:09:09.350396Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T14:09:09.350579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-06T14:09:09.35061Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-06T14:09:09.353476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"}
{"level":"info","ts":"2026-05-06T14:09:09.354153Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T14:09:09.356824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-06T14:09:09.356856Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T14:09:09.356956Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T14:09:12.911694Z","caller":"traceutil/trace.go:171","msg":"trace[2108645357] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"331.651227ms","start":"2026-05-06T14:09:12.579986Z","end":"2026-05-06T14:09:12.911637Z","steps":["trace[2108645357] 'process raft request'  (duration: 313.944721ms)","trace[2108645357] 'compare'  (duration: 17.51569ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:09:12.912432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:12.579957Z","time spent":"331.908449ms","remote":"127.0.0.1:58252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":768,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" value_size:685 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:09:13.263372Z","caller":"traceutil/trace.go:171","msg":"trace[1052587489] linearizableReadLoop","detail":"{readStateIndex:179; appliedIndex:177; }","duration":"176.064226ms","start":"2026-05-06T14:09:13.087274Z","end":"2026-05-06T14:09:13.263338Z","steps":["trace[1052587489] 'read index received'  (duration: 91.02876ms)","trace[1052587489] 'applied index is now lower than readState.Index'  (duration: 85.034296ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:09:13.263587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.279474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:13.263646Z","caller":"traceutil/trace.go:171","msg":"trace[293273270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:175; }","duration":"176.406394ms","start":"2026-05-06T14:09:13.087222Z","end":"2026-05-06T14:09:13.263629Z","steps":["trace[293273270] 'agreement among raft nodes before linearized reading'  (duration: 176.264102ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:09:13.263888Z","caller":"traceutil/trace.go:171","msg":"trace[274531349] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"184.215202ms","start":"2026-05-06T14:09:13.079659Z","end":"2026-05-06T14:09:13.263874Z","steps":["trace[274531349] 'process raft request'  (duration: 98.62837ms)","trace[274531349] 'compare'  (duration: 84.84356ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:09:13.26419Z","caller":"traceutil/trace.go:171","msg":"trace[1213282310] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"183.645583ms","start":"2026-05-06T14:09:13.080472Z","end":"2026-05-06T14:09:13.264118Z","steps":["trace[1213282310] 'process raft request'  (duration: 182.827275ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:13.79822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307090606,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T14:09:14.217842Z","caller":"traceutil/trace.go:171","msg":"trace[785601311] linearizableReadLoop","detail":"{readStateIndex:180; appliedIndex:179; }","duration":"920.17063ms","start":"2026-05-06T14:09:13.297606Z","end":"2026-05-06T14:09:14.217776Z","steps":["trace[785601311] 'read index received'  (duration: 900.521044ms)","trace[785601311] 'applied index is now lower than readState.Index'  (duration: 19.648086ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:09:14.217984Z","caller":"traceutil/trace.go:171","msg":"trace[2016938651] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"946.32972ms","start":"2026-05-06T14:09:13.271639Z","end":"2026-05-06T14:09:14.217969Z","steps":["trace[2016938651] 'process raft request'  (duration: 926.565674ms)","trace[2016938651] 'compare'  (duration: 19.413117ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:09:14.218083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:13.2716Z","time spent":"946.415448ms","remote":"127.0.0.1:58252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" value_size:679 >> failure:<>"}
{"level":"warn","ts":"2026-05-06T14:09:14.218131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.904974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:14.218188Z","caller":"traceutil/trace.go:171","msg":"trace[1326964036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:176; }","duration":"849.014403ms","start":"2026-05-06T14:09:13.369159Z","end":"2026-05-06T14:09:14.218174Z","steps":["trace[1326964036] 'agreement among raft nodes before linearized reading'  (duration: 848.890932ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:14.218223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:13.369137Z","time spent":"849.078559ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T14:09:14.218395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.789363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:14.218424Z","caller":"traceutil/trace.go:171","msg":"trace[1442022119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:176; }","duration":"920.878521ms","start":"2026-05-06T14:09:13.297537Z","end":"2026-05-06T14:09:14.218415Z","steps":["trace[1442022119] 'agreement among raft nodes before linearized reading'  (duration: 920.836647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:14.218425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.655053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T14:09:14.218494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:13.297511Z","time spent":"920.974309ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-06T14:09:14.218508Z","caller":"traceutil/trace.go:171","msg":"trace[802916190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:176; }","duration":"130.84961ms","start":"2026-05-06T14:09:14.087644Z","end":"2026-05-06T14:09:14.218494Z","steps":["trace[802916190] 'agreement among raft nodes before linearized reading'  (duration: 130.741271ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:14.788571Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307090610,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T14:09:15.289217Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307090610,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T14:09:15.789544Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307090610,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T14:09:16.128085Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.904818861s","expected-duration":"1s"}
{"level":"warn","ts":"2026-05-06T14:09:16.287943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999945633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-06T14:09:16.288141Z","caller":"traceutil/trace.go:171","msg":"trace[307780523] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000204425s","start":"2026-05-06T14:09:14.28791Z","end":"2026-05-06T14:09:16.288114Z","steps":["trace[307780523] 'agreement among raft nodes before linearized reading'  (duration: 1.999970965s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:16.288236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:14.287885Z","time spent":"2.000334105s","remote":"127.0.0.1:57918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/06 14:09:16 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-06T14:09:16.365822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.789584ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307090611 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-06T14:09:16.366129Z","caller":"traceutil/trace.go:171","msg":"trace[600174236] linearizableReadLoop","detail":"{readStateIndex:183; appliedIndex:180; }","duration":"2.078151216s","start":"2026-05-06T14:09:14.287957Z","end":"2026-05-06T14:09:16.366108Z","steps":["trace[600174236] 'read index received'  (duration: 1.840809965s)","trace[600174236] 'applied index is now lower than readState.Index'  (duration: 237.340351ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:09:16.366151Z","caller":"traceutil/trace.go:171","msg":"trace[563249306] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"2.143303328s","start":"2026-05-06T14:09:14.222805Z","end":"2026-05-06T14:09:16.366108Z","steps":["trace[563249306] 'process raft request'  (duration: 1.90599707s)","trace[563249306] 'compare'  (duration: 235.920621ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:09:16.366343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:14.222746Z","time spent":"2.143492923s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:09:16.366324Z","caller":"traceutil/trace.go:171","msg":"trace[1072832312] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"2.143063858s","start":"2026-05-06T14:09:14.223204Z","end":"2026-05-06T14:09:16.366268Z","steps":["trace[1072832312] 'process raft request'  (duration: 2.142788084s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:16.366541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:14.223179Z","time spent":"2.143239252s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<>"}
{"level":"warn","ts":"2026-05-06T14:09:16.366752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286977288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:16.366858Z","caller":"traceutil/trace.go:171","msg":"trace[494513694] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:179; }","duration":"1.287184854s","start":"2026-05-06T14:09:15.079648Z","end":"2026-05-06T14:09:16.366833Z","steps":["trace[494513694] 'agreement among raft nodes before linearized reading'  (duration: 1.286883129s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:16.366904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:15.079614Z","time spent":"1.287282452s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:09:16.367046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.039852662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T14:09:16.367087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08175071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:16.367113Z","caller":"traceutil/trace.go:171","msg":"trace[55894401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:179; }","duration":"1.081773822s","start":"2026-05-06T14:09:15.28533Z","end":"2026-05-06T14:09:16.367104Z","steps":["trace[55894401] 'agreement among raft nodes before linearized reading'  (duration: 1.081738389s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:16.367131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:15.285274Z","time spent":"1.081853689s","remote":"127.0.0.1:57914","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-06T14:09:16.367173Z","caller":"traceutil/trace.go:171","msg":"trace[409919641] transaction","detail":"{read_only:false; response_revision:179; number_of_response:1; }","duration":"2.143324169s","start":"2026-05-06T14:09:14.223836Z","end":"2026-05-06T14:09:16.36716Z","steps":["trace[409919641] 'process raft request'  (duration: 2.142235197s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:16.36724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:14.223819Z","time spent":"2.143392125s","remote":"127.0.0.1:58252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" value_size:676 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:09:16.367121Z","caller":"traceutil/trace.go:171","msg":"trace[2085483158] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:179; }","duration":"1.040003425s","start":"2026-05-06T14:09:15.327097Z","end":"2026-05-06T14:09:16.3671Z","steps":["trace[2085483158] 'agreement among raft nodes before linearized reading'  (duration: 1.039886075s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:16.367301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:15.327072Z","time spent":"1.040219343s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-06T14:09:49.31572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.648955ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307091288 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:491 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T14:09:49.315912Z","caller":"traceutil/trace.go:171","msg":"trace[353388360] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:517; }","duration":"681.033682ms","start":"2026-05-06T14:09:48.634863Z","end":"2026-05-06T14:09:49.315897Z","steps":["trace[353388360] 'read index received'  (duration: 448.994365ms)","trace[353388360] 'applied index is now lower than readState.Index'  (duration: 232.038037ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:09:49.315994Z","caller":"traceutil/trace.go:171","msg":"trace[891649022] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"440.353962ms","start":"2026-05-06T14:09:48.875633Z","end":"2026-05-06T14:09:49.315987Z","steps":["trace[891649022] 'process raft request'  (duration: 440.233434ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:49.316046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:48.875604Z","time spent":"440.41854ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:474 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:49.316282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.410655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:09:49.316317Z","caller":"traceutil/trace.go:171","msg":"trace[783889961] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"690.605226ms","start":"2026-05-06T14:09:48.62566Z","end":"2026-05-06T14:09:49.316266Z","steps":["trace[783889961] 'process raft request'  (duration: 458.194736ms)","trace[783889961] 'compare'  (duration: 231.531747ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:09:49.316366Z","caller":"traceutil/trace.go:171","msg":"trace[1063180333] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:498; }","duration":"681.501063ms","start":"2026-05-06T14:09:48.63483Z","end":"2026-05-06T14:09:49.316331Z","steps":["trace[1063180333] 'agreement among raft nodes before linearized reading'  (duration: 681.412235ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:49.316424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:48.634811Z","time spent":"681.604092ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:09:49.316255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.952111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:49.316529Z","caller":"traceutil/trace.go:171","msg":"trace[1285724831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:498; }","duration":"661.294105ms","start":"2026-05-06T14:09:48.655219Z","end":"2026-05-06T14:09:49.316514Z","steps":["trace[1285724831] 'agreement among raft nodes before linearized reading'  (duration: 660.957241ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:09:49.316542Z","caller":"traceutil/trace.go:171","msg":"trace[1919717742] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"690.810963ms","start":"2026-05-06T14:09:48.625716Z","end":"2026-05-06T14:09:49.316527Z","steps":["trace[1919717742] 'process raft request'  (duration: 690.112476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:49.316568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:48.655185Z","time spent":"661.373063ms","remote":"127.0.0.1:57918","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-06T14:09:49.316561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:48.625644Z","time spent":"690.782893ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:491 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:49.316602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:48.625699Z","time spent":"690.876922ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:492 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:52.092362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.696852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307091374 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" value_size:911 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-06T14:09:52.092524Z","caller":"traceutil/trace.go:171","msg":"trace[544546516] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"813.207917ms","start":"2026-05-06T14:09:51.279289Z","end":"2026-05-06T14:09:52.092497Z","steps":["trace[544546516] 'process raft request'  (duration: 79.279808ms)","trace[544546516] 'compare'  (duration: 733.377057ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:09:52.092611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.279276Z","time spent":"813.308235ms","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" value_size:911 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:09:52.104288Z","caller":"traceutil/trace.go:171","msg":"trace[205119976] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"824.61054ms","start":"2026-05-06T14:09:51.279648Z","end":"2026-05-06T14:09:52.104258Z","steps":["trace[205119976] 'process raft request'  (duration: 824.311374ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:09:52.10432Z","caller":"traceutil/trace.go:171","msg":"trace[1112298084] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"824.593368ms","start":"2026-05-06T14:09:51.279689Z","end":"2026-05-06T14:09:52.104282Z","steps":["trace[1112298084] 'process raft request'  (duration: 824.46357ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.104425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.279643Z","time spent":"824.709648ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" mod_revision:540 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" value_size:30272 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:52.104552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.279685Z","time spent":"824.731857ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" mod_revision:543 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" value_size:28628 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" > >"}
{"level":"info","ts":"2026-05-06T14:09:52.104627Z","caller":"traceutil/trace.go:171","msg":"trace[250658437] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"824.659739ms","start":"2026-05-06T14:09:51.279916Z","end":"2026-05-06T14:09:52.104576Z","steps":["trace[250658437] 'process raft request'  (duration: 824.440162ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:09:52.104571Z","caller":"traceutil/trace.go:171","msg":"trace[1964925942] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"824.738077ms","start":"2026-05-06T14:09:51.279745Z","end":"2026-05-06T14:09:52.104483Z","steps":["trace[1964925942] 'process raft request'  (duration: 824.47858ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:09:52.104732Z","caller":"traceutil/trace.go:171","msg":"trace[528274265] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"819.479018ms","start":"2026-05-06T14:09:51.285239Z","end":"2026-05-06T14:09:52.104718Z","steps":["trace[528274265] 'process raft request'  (duration: 819.202282ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.104789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.285221Z","time spent":"819.541357ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" value_size:63787 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:09:52.104813Z","caller":"traceutil/trace.go:171","msg":"trace[798416693] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"818.181678ms","start":"2026-05-06T14:09:51.286618Z","end":"2026-05-06T14:09:52.1048Z","steps":["trace[798416693] 'process raft request'  (duration: 818.01531ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.104839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.27988Z","time spent":"824.839556ms","remote":"127.0.0.1:58446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" value_size:911 >> failure:<>"}
{"level":"warn","ts":"2026-05-06T14:09:52.104876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.286609Z","time spent":"818.230397ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" mod_revision:548 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" value_size:10741 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" > >"}
{"level":"info","ts":"2026-05-06T14:09:52.104915Z","caller":"traceutil/trace.go:171","msg":"trace[1072901908] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"817.597346ms","start":"2026-05-06T14:09:51.287297Z","end":"2026-05-06T14:09:52.104894Z","steps":["trace[1072901908] 'process raft request'  (duration: 817.390079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.10493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.279742Z","time spent":"824.999384ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" mod_revision:544 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" value_size:30291 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:52.104997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.287285Z","time spent":"817.675585ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" value_size:79271 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:09:52.105122Z","caller":"traceutil/trace.go:171","msg":"trace[872504257] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"816.63766ms","start":"2026-05-06T14:09:51.288472Z","end":"2026-05-06T14:09:52.105109Z","steps":["trace[872504257] 'process raft request'  (duration: 816.285055ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:09:52.105128Z","caller":"traceutil/trace.go:171","msg":"trace[810559858] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:572; }","duration":"783.896188ms","start":"2026-05-06T14:09:51.321216Z","end":"2026-05-06T14:09:52.105112Z","steps":["trace[810559858] 'read index received'  (duration: 37.329415ms)","trace[810559858] 'applied index is now lower than readState.Index'  (duration: 746.566023ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:09:52.105183Z","caller":"traceutil/trace.go:171","msg":"trace[1463360326] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"814.018601ms","start":"2026-05-06T14:09:51.291139Z","end":"2026-05-06T14:09:52.105158Z","steps":["trace[1463360326] 'process raft request'  (duration: 813.855493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.105193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.288465Z","time spent":"816.68554ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" mod_revision:549 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" value_size:9034 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:52.105232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.014176ms","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-06T14:09:52.105265Z","caller":"traceutil/trace.go:171","msg":"trace[520113724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"784.084305ms","start":"2026-05-06T14:09:51.321172Z","end":"2026-05-06T14:09:52.105256Z","steps":["trace[520113724] 'agreement among raft nodes before linearized reading'  (duration: 784.007296ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.105281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.291126Z","time spent":"814.09587ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" mod_revision:545 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" value_size:58743 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:52.105294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.321147Z","time spent":"784.139024ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T14:09:52.113052Z","caller":"traceutil/trace.go:171","msg":"trace[814777479] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"724.026066ms","start":"2026-05-06T14:09:51.388977Z","end":"2026-05-06T14:09:52.113003Z","steps":["trace[814777479] 'process raft request'  (duration: 723.138588ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.113365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.388947Z","time spent":"724.286992ms","remote":"127.0.0.1:57956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" value_size:149804 >> failure:<>"}
{"level":"warn","ts":"2026-05-06T14:09:52.137707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.944545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:09:52.137775Z","caller":"traceutil/trace.go:171","msg":"trace[561102589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"816.050903ms","start":"2026-05-06T14:09:51.321709Z","end":"2026-05-06T14:09:52.137759Z","steps":["trace[561102589] 'agreement among raft nodes before linearized reading'  (duration: 815.937885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.1378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.321689Z","time spent":"816.106102ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-06T14:09:52.137996Z","caller":"traceutil/trace.go:171","msg":"trace[1604066780] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"306.485935ms","start":"2026-05-06T14:09:51.831504Z","end":"2026-05-06T14:09:52.13799Z","steps":["trace[1604066780] 'process raft request'  (duration: 305.807613ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.138083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.831479Z","time spent":"306.540933ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:481 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-06T14:09:52.138562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.066916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:09:52.13864Z","caller":"traceutil/trace.go:171","msg":"trace[1772236751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:562; }","duration":"810.135666ms","start":"2026-05-06T14:09:51.32846Z","end":"2026-05-06T14:09:52.138596Z","steps":["trace[1772236751] 'agreement among raft nodes before linearized reading'  (duration: 809.727032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.138682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.328438Z","time spent":"810.234644ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:09:52.138833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.412007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:09:52.138953Z","caller":"traceutil/trace.go:171","msg":"trace[1023748371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:562; }","duration":"484.580514ms","start":"2026-05-06T14:09:51.654345Z","end":"2026-05-06T14:09:52.138926Z","steps":["trace[1023748371] 'agreement among raft nodes before linearized reading'  (duration: 483.831935ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:52.139022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:51.654323Z","time spent":"484.674253ms","remote":"127.0.0.1:57914","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-06T14:09:59.095828Z","caller":"traceutil/trace.go:171","msg":"trace[1940263924] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"597.946315ms","start":"2026-05-06T14:09:58.497849Z","end":"2026-05-06T14:09:59.095796Z","steps":["trace[1940263924] 'process raft request'  (duration: 597.739697ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:59.096017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:58.497829Z","time spent":"598.096055ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-77v2v\" mod_revision:529 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-77v2v\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-77v2v\" > >"}
{"level":"info","ts":"2026-05-06T14:09:59.649468Z","caller":"traceutil/trace.go:171","msg":"trace[905781389] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.124507196s","start":"2026-05-06T14:09:58.524906Z","end":"2026-05-06T14:09:59.649413Z","steps":["trace[905781389] 'process raft request'  (duration: 1.120847645s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:59.649615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.840583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:09:59.649649Z","caller":"traceutil/trace.go:171","msg":"trace[76961335] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:670; }","duration":"958.569844ms","start":"2026-05-06T14:09:58.690747Z","end":"2026-05-06T14:09:59.649317Z","steps":["trace[76961335] 'read index received'  (duration: 404.885709ms)","trace[76961335] 'applied index is now lower than readState.Index'  (duration: 553.682925ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:09:59.649712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:58.524868Z","time spent":"1.124715566s","remote":"127.0.0.1:57996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"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:638 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-06T14:09:59.64978Z","caller":"traceutil/trace.go:171","msg":"trace[2000638671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"959.030242ms","start":"2026-05-06T14:09:58.6907Z","end":"2026-05-06T14:09:59.64973Z","steps":["trace[2000638671] 'agreement among raft nodes before linearized reading'  (duration: 958.769644ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:09:59.649859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:58.690677Z","time spent":"959.137631ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-06T14:10:00.784911Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.115197334s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-06T14:10:00.82896Z","caller":"traceutil/trace.go:171","msg":"trace[383763141] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"1.173040651s","start":"2026-05-06T14:09:59.655885Z","end":"2026-05-06T14:10:00.828926Z","steps":["trace[383763141] 'read index received'  (duration: 13.806412ms)","trace[383763141] 'applied index is now lower than readState.Index'  (duration: 1.159233269s)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:10:00.829171Z","caller":"traceutil/trace.go:171","msg":"trace[1957102353] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.174811942s","start":"2026-05-06T14:09:59.654324Z","end":"2026-05-06T14:10:00.829136Z","steps":["trace[1957102353] 'process raft request'  (duration: 1.130809547s)","trace[1957102353] 'compare'  (duration: 43.691917ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:10:00.829225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17334845s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:10:00.82929Z","caller":"traceutil/trace.go:171","msg":"trace[2144347154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"1.1734552s","start":"2026-05-06T14:09:59.655817Z","end":"2026-05-06T14:10:00.829272Z","steps":["trace[2144347154] 'agreement among raft nodes before linearized reading'  (duration: 1.17332967s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:00.829332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:59.6543Z","time spent":"1.174949302s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:633 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-06T14:10:00.829351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:59.655807Z","time spent":"1.173530629s","remote":"127.0.0.1:57914","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-06T14:10:00.926562Z","caller":"traceutil/trace.go:171","msg":"trace[3706548] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.212259645s","start":"2026-05-06T14:09:59.714267Z","end":"2026-05-06T14:10:00.926527Z","steps":["trace[3706548] 'process raft request'  (duration: 1.212003195s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:00.926687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.046212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-06T14:10:00.926726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:09:59.714241Z","time spent":"1.212414494s","remote":"127.0.0.1:58138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"info","ts":"2026-05-06T14:10:00.926739Z","caller":"traceutil/trace.go:171","msg":"trace[991179065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"718.162412ms","start":"2026-05-06T14:10:00.208563Z","end":"2026-05-06T14:10:00.926725Z","steps":["trace[991179065] 'agreement among raft nodes before linearized reading'  (duration: 717.931373ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:00.926688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.598753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-05-06T14:10:00.926882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.208537Z","time spent":"718.332711ms","remote":"127.0.0.1:58164","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-06T14:10:00.926896Z","caller":"traceutil/trace.go:171","msg":"trace[1378368231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"720.846252ms","start":"2026-05-06T14:10:00.20603Z","end":"2026-05-06T14:10:00.926877Z","steps":["trace[1378368231] 'agreement among raft nodes before linearized reading'  (duration: 720.461824ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:00.926936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.206015Z","time spent":"720.910002ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:10:00.926978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.358734ms","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-06T14:10:00.927061Z","caller":"traceutil/trace.go:171","msg":"trace[289517913] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"744.492753ms","start":"2026-05-06T14:10:00.182546Z","end":"2026-05-06T14:10:00.927039Z","steps":["trace[289517913] 'agreement among raft nodes before linearized reading'  (duration: 744.245394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:00.927101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.182519Z","time spent":"744.573063ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-06T14:10:01.690642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.56556ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307091551 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:643 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T14:10:01.690855Z","caller":"traceutil/trace.go:171","msg":"trace[172097234] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"758.741689ms","start":"2026-05-06T14:10:00.932067Z","end":"2026-05-06T14:10:01.690809Z","steps":["trace[172097234] 'process raft request'  (duration: 472.892779ms)","trace[172097234] 'compare'  (duration: 285.143141ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:10:01.691139Z","caller":"traceutil/trace.go:171","msg":"trace[957375342] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"757.129926ms","start":"2026-05-06T14:10:00.933986Z","end":"2026-05-06T14:10:01.691116Z","steps":["trace[957375342] 'process raft request'  (duration: 757.077216ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:10:01.691155Z","caller":"traceutil/trace.go:171","msg":"trace[86195232] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"757.227295ms","start":"2026-05-06T14:10:00.933912Z","end":"2026-05-06T14:10:01.691139Z","steps":["trace[86195232] 'process raft request'  (duration: 756.871576ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:10:01.691192Z","caller":"traceutil/trace.go:171","msg":"trace[1129846899] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"757.272375ms","start":"2026-05-06T14:10:00.93389Z","end":"2026-05-06T14:10:01.691162Z","steps":["trace[1129846899] 'read index received'  (duration: 471.090686ms)","trace[1129846899] 'applied index is now lower than readState.Index'  (duration: 286.178559ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:10:01.691298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.933963Z","time spent":"757.222966ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:644 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-06T14:10:01.691228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.93389Z","time spent":"757.295715ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:642 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-06T14:10:01.691264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.932006Z","time spent":"759.126038ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:643 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-06T14:10:01.691341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.451894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-05-06T14:10:01.691457Z","caller":"traceutil/trace.go:171","msg":"trace[1767634307] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:653; }","duration":"757.617944ms","start":"2026-05-06T14:10:00.933832Z","end":"2026-05-06T14:10:01.691449Z","steps":["trace[1767634307] 'agreement among raft nodes before linearized reading'  (duration: 757.455584ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:01.69148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.933805Z","time spent":"757.669604ms","remote":"127.0.0.1:58106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "}
{"level":"warn","ts":"2026-05-06T14:10:01.69147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.015474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:10:01.692389Z","caller":"traceutil/trace.go:171","msg":"trace[1890679441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"755.946291ms","start":"2026-05-06T14:10:00.936419Z","end":"2026-05-06T14:10:01.692366Z","steps":["trace[1890679441] 'agreement among raft nodes before linearized reading'  (duration: 754.944413ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:01.692449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:00.936411Z","time spent":"756.02081ms","remote":"127.0.0.1:57914","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-06T14:10:02.832127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.614866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:10:02.832197Z","caller":"traceutil/trace.go:171","msg":"trace[34812131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"174.701505ms","start":"2026-05-06T14:10:02.65748Z","end":"2026-05-06T14:10:02.832182Z","steps":["trace[34812131] 'range keys from in-memory index tree'  (duration: 174.533616ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:18.554171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.786466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-06T14:10:18.554253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.026413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5xxjz\" ","response":"range_response_count:1 size:3964"}
{"level":"warn","ts":"2026-05-06T14:10:18.55429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.334982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-06T14:10:18.554359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.020643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:10:18.554373Z","caller":"traceutil/trace.go:171","msg":"trace[822508707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"736.507575ms","start":"2026-05-06T14:10:17.817846Z","end":"2026-05-06T14:10:18.554354Z","steps":["trace[822508707] 'range keys from in-memory index tree'  (duration: 736.121349ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:18.554357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.724478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:10:18.554394Z","caller":"traceutil/trace.go:171","msg":"trace[245586226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"722.091154ms","start":"2026-05-06T14:10:17.832293Z","end":"2026-05-06T14:10:18.554384Z","steps":["trace[245586226] 'range keys from in-memory index tree'  (duration: 721.902981ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:18.55442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:17.817816Z","time spent":"736.591996ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-06T14:10:18.554465Z","caller":"traceutil/trace.go:171","msg":"trace[272065752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"897.87368ms","start":"2026-05-06T14:10:17.656547Z","end":"2026-05-06T14:10:18.554421Z","steps":["trace[272065752] 'range keys from in-memory index tree'  (duration: 897.624996ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:18.554435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:17.832269Z","time spent":"722.157675ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-06T14:10:18.554324Z","caller":"traceutil/trace.go:171","msg":"trace[292169184] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5xxjz; range_end:; response_count:1; response_revision:811; }","duration":"957.148555ms","start":"2026-05-06T14:10:17.597157Z","end":"2026-05-06T14:10:18.554305Z","steps":["trace[292169184] 'range keys from in-memory index tree'  (duration: 956.857291ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:18.554499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:17.656519Z","time spent":"897.972891ms","remote":"127.0.0.1:57914","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-06T14:10:18.554267Z","caller":"traceutil/trace.go:171","msg":"trace[477938200] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"715.932788ms","start":"2026-05-06T14:10:17.838313Z","end":"2026-05-06T14:10:18.554246Z","steps":["trace[477938200] 'range keys from in-memory index tree'  (duration: 715.606853ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:18.55454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:17.59713Z","time spent":"957.388138ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5xxjz\" "}
{"level":"warn","ts":"2026-05-06T14:10:18.554585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:17.838286Z","time spent":"716.291584ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T14:10:26.342379Z","caller":"traceutil/trace.go:171","msg":"trace[1992552690] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"156.278572ms","start":"2026-05-06T14:10:26.186076Z","end":"2026-05-06T14:10:26.342355Z","steps":["trace[1992552690] 'process raft request'  (duration: 143.288783ms)","trace[1992552690] 'compare'  (duration: 12.734603ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:10:32.87355Z","caller":"traceutil/trace.go:171","msg":"trace[1667037173] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"100.838383ms","start":"2026-05-06T14:10:32.772694Z","end":"2026-05-06T14:10:32.873533Z","steps":["trace[1667037173] 'process raft request'  (duration: 100.737291ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:49.335518Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307092675,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T14:10:49.746755Z","caller":"traceutil/trace.go:171","msg":"trace[405601349] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1249; }","duration":"911.730399ms","start":"2026-05-06T14:10:48.834999Z","end":"2026-05-06T14:10:49.74673Z","steps":["trace[405601349] 'read index received'  (duration: 911.365146ms)","trace[405601349] 'applied index is now lower than readState.Index'  (duration: 363.813µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:10:49.746931Z","caller":"traceutil/trace.go:171","msg":"trace[1693804053] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"923.029218ms","start":"2026-05-06T14:10:48.823766Z","end":"2026-05-06T14:10:49.746795Z","steps":["trace[1693804053] 'process raft request'  (duration: 922.792019ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:49.747125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:48.823745Z","time spent":"923.292886ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1201 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-06T14:10:49.747391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.731749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:10:49.747461Z","caller":"traceutil/trace.go:171","msg":"trace[1650118346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1212; }","duration":"772.843154ms","start":"2026-05-06T14:10:48.974595Z","end":"2026-05-06T14:10:49.747438Z","steps":["trace[1650118346] 'agreement among raft nodes before linearized reading'  (duration: 772.529992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:49.747459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.451285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-06T14:10:49.747505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:48.974572Z","time spent":"772.921036ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-06T14:10:49.747533Z","caller":"traceutil/trace.go:171","msg":"trace[99712689] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1212; }","duration":"912.563169ms","start":"2026-05-06T14:10:48.834945Z","end":"2026-05-06T14:10:49.747508Z","steps":["trace[99712689] 'agreement among raft nodes before linearized reading'  (duration: 911.995969ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:49.748005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.590816ms","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-06T14:10:49.748065Z","caller":"traceutil/trace.go:171","msg":"trace[762667849] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1212; }","duration":"209.649218ms","start":"2026-05-06T14:10:49.538398Z","end":"2026-05-06T14:10:49.748048Z","steps":["trace[762667849] 'agreement among raft nodes before linearized reading'  (duration: 209.514763ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:49.748213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:48.834928Z","time spent":"913.274675ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:10:49.748208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.989624ms","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-06T14:10:49.748343Z","caller":"traceutil/trace.go:171","msg":"trace[26059664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1212; }","duration":"686.163341ms","start":"2026-05-06T14:10:49.062161Z","end":"2026-05-06T14:10:49.748324Z","steps":["trace[26059664] 'agreement among raft nodes before linearized reading'  (duration: 685.85723ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:10:49.748429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:10:49.06214Z","time spent":"686.274674ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-06T14:11:14.027021Z","caller":"traceutil/trace.go:171","msg":"trace[1505150870] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"139.695099ms","start":"2026-05-06T14:11:13.887302Z","end":"2026-05-06T14:11:14.026997Z","steps":["trace[1505150870] 'process raft request'  (duration: 139.567803ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:14.06109Z","caller":"traceutil/trace.go:171","msg":"trace[1570086808] linearizableReadLoop","detail":"{readStateIndex:1526; appliedIndex:1524; }","duration":"102.447598ms","start":"2026-05-06T14:11:13.958622Z","end":"2026-05-06T14:11:14.061069Z","steps":["trace[1570086808] 'read index received'  (duration: 68.244237ms)","trace[1570086808] 'applied index is now lower than readState.Index'  (duration: 34.202361ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:11:14.061196Z","caller":"traceutil/trace.go:171","msg":"trace[814180961] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"106.924181ms","start":"2026-05-06T14:11:13.954261Z","end":"2026-05-06T14:11:14.061186Z","steps":["trace[814180961] 'process raft request'  (duration: 106.702311ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:14.061555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.922071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:11:14.061609Z","caller":"traceutil/trace.go:171","msg":"trace[55042795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1479; }","duration":"103.015836ms","start":"2026-05-06T14:11:13.958582Z","end":"2026-05-06T14:11:14.061598Z","steps":["trace[55042795] 'agreement among raft nodes before linearized reading'  (duration: 102.851347ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:14.238268Z","caller":"traceutil/trace.go:171","msg":"trace[1084628312] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"168.363826ms","start":"2026-05-06T14:11:14.069882Z","end":"2026-05-06T14:11:14.238246Z","steps":["trace[1084628312] 'process raft request'  (duration: 166.087296ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:14.238488Z","caller":"traceutil/trace.go:171","msg":"trace[822245963] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"167.568838ms","start":"2026-05-06T14:11:14.070867Z","end":"2026-05-06T14:11:14.238436Z","steps":["trace[822245963] 'process raft request'  (duration: 167.300905ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:14.238813Z","caller":"traceutil/trace.go:171","msg":"trace[2119982436] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"166.207353ms","start":"2026-05-06T14:11:14.072594Z","end":"2026-05-06T14:11:14.238801Z","steps":["trace[2119982436] 'process raft request'  (duration: 165.788463ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.46315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307094008,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T14:11:38.54298Z","caller":"traceutil/trace.go:171","msg":"trace[1244129992] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"643.904776ms","start":"2026-05-06T14:11:37.899038Z","end":"2026-05-06T14:11:38.542943Z","steps":["trace[1244129992] 'process raft request'  (duration: 643.665033ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.543329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:37.899005Z","time spent":"644.189592ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1859 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T14:11:38.739124Z","caller":"traceutil/trace.go:171","msg":"trace[71802186] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"831.774295ms","start":"2026-05-06T14:11:37.907323Z","end":"2026-05-06T14:11:38.739098Z","steps":["trace[71802186] 'process raft request'  (duration: 770.508725ms)","trace[71802186] 'compare'  (duration: 60.36543ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:11:38.73926Z","caller":"traceutil/trace.go:171","msg":"trace[796090744] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1964; }","duration":"777.111304ms","start":"2026-05-06T14:11:37.962124Z","end":"2026-05-06T14:11:38.739235Z","steps":["trace[796090744] 'read index received'  (duration: 580.650932ms)","trace[796090744] 'applied index is now lower than readState.Index'  (duration: 196.458882ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:11:38.739291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:37.907294Z","time spent":"831.910692ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1860 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T14:11:38.739389Z","caller":"traceutil/trace.go:171","msg":"trace[334967053] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"595.289463ms","start":"2026-05-06T14:11:38.144088Z","end":"2026-05-06T14:11:38.739378Z","steps":["trace[334967053] 'process raft request'  (duration: 594.930933ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.739507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.144061Z","time spent":"595.361267ms","remote":"127.0.0.1:58164","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:1868 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-06T14:11:38.739651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.568461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-05-06T14:11:38.739718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.676317ms","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-06T14:11:38.739764Z","caller":"traceutil/trace.go:171","msg":"trace[1024994403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1892; }","duration":"588.737191ms","start":"2026-05-06T14:11:38.151006Z","end":"2026-05-06T14:11:38.739743Z","steps":["trace[1024994403] 'agreement among raft nodes before linearized reading'  (duration: 588.469665ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.739807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.150988Z","time spent":"588.810305ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T14:11:38.739804Z","caller":"traceutil/trace.go:171","msg":"trace[289392565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1892; }","duration":"292.779893ms","start":"2026-05-06T14:11:38.446973Z","end":"2026-05-06T14:11:38.739752Z","steps":["trace[289392565] 'agreement among raft nodes before linearized reading'  (duration: 292.516098ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.191378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:11:38.740174Z","caller":"traceutil/trace.go:171","msg":"trace[585413457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1892; }","duration":"299.288503ms","start":"2026-05-06T14:11:38.440877Z","end":"2026-05-06T14:11:38.740165Z","steps":["trace[585413457] 'agreement among raft nodes before linearized reading'  (duration: 299.191808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.355618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:11:38.740279Z","caller":"traceutil/trace.go:171","msg":"trace[997471448] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1892; }","duration":"258.439262ms","start":"2026-05-06T14:11:38.481829Z","end":"2026-05-06T14:11:38.740268Z","steps":["trace[997471448] 'agreement among raft nodes before linearized reading'  (duration: 258.351528ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.195414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-05-06T14:11:38.740353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.061201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:11:38.740381Z","caller":"traceutil/trace.go:171","msg":"trace[1132416785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1892; }","duration":"301.127634ms","start":"2026-05-06T14:11:38.439244Z","end":"2026-05-06T14:11:38.740372Z","steps":["trace[1132416785] 'agreement among raft nodes before linearized reading'  (duration: 301.05285ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.439221Z","time spent":"301.178227ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-06T14:11:38.740409Z","caller":"traceutil/trace.go:171","msg":"trace[177858306] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e; range_end:; response_count:1; response_revision:1892; }","duration":"778.272388ms","start":"2026-05-06T14:11:37.962084Z","end":"2026-05-06T14:11:38.740356Z","steps":["trace[177858306] 'agreement among raft nodes before linearized reading'  (duration: 778.110719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:37.962066Z","time spent":"778.417936ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" "}
{"level":"warn","ts":"2026-05-06T14:11:38.740659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.829368ms","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-06T14:11:38.740727Z","caller":"traceutil/trace.go:171","msg":"trace[126194971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1892; }","duration":"536.926533ms","start":"2026-05-06T14:11:38.203791Z","end":"2026-05-06T14:11:38.740718Z","steps":["trace[126194971] 'agreement among raft nodes before linearized reading'  (duration: 536.803736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.74066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.140272ms","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-06T14:11:38.740759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.203778Z","time spent":"536.973266ms","remote":"127.0.0.1:58164","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-06T14:11:38.740782Z","caller":"traceutil/trace.go:171","msg":"trace[503955416] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1892; }","duration":"291.261009ms","start":"2026-05-06T14:11:38.449507Z","end":"2026-05-06T14:11:38.740768Z","steps":["trace[503955416] 'agreement among raft nodes before linearized reading'  (duration: 291.020456ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.455954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:11:38.740847Z","caller":"traceutil/trace.go:171","msg":"trace[617152590] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1892; }","duration":"483.789012ms","start":"2026-05-06T14:11:38.257042Z","end":"2026-05-06T14:11:38.740831Z","steps":["trace[617152590] 'agreement among raft nodes before linearized reading'  (duration: 483.478695ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:38.740896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.25701Z","time spent":"483.871057ms","remote":"127.0.0.1:58158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"info","ts":"2026-05-06T14:11:38.936167Z","caller":"traceutil/trace.go:171","msg":"trace[194942079] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"190.620499ms","start":"2026-05-06T14:11:38.745517Z","end":"2026-05-06T14:11:38.936138Z","steps":["trace[194942079] 'process raft request'  (duration: 190.417108ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:39.097693Z","caller":"traceutil/trace.go:171","msg":"trace[1389345741] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"351.364918ms","start":"2026-05-06T14:11:38.746301Z","end":"2026-05-06T14:11:39.097666Z","steps":["trace[1389345741] 'process raft request'  (duration: 351.296714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:39.097742Z","caller":"traceutil/trace.go:171","msg":"trace[2094559300] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"351.456002ms","start":"2026-05-06T14:11:38.746253Z","end":"2026-05-06T14:11:39.097709Z","steps":["trace[2094559300] 'process raft request'  (duration: 351.305684ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:39.09785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.746297Z","time spent":"351.477113ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1869 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-06T14:11:39.097914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.746243Z","time spent":"351.571589ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1874 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-06T14:11:39.097924Z","caller":"traceutil/trace.go:171","msg":"trace[2069837234] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"351.576949ms","start":"2026-05-06T14:11:38.746332Z","end":"2026-05-06T14:11:39.097909Z","steps":["trace[2069837234] 'process raft request'  (duration: 351.297654ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:39.097992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.746327Z","time spent":"351.632402ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1871 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-06T14:11:39.098069Z","caller":"traceutil/trace.go:171","msg":"trace[2079451245] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"349.61996ms","start":"2026-05-06T14:11:38.748437Z","end":"2026-05-06T14:11:39.098057Z","steps":["trace[2079451245] 'process raft request'  (duration: 349.331354ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:39.098036Z","caller":"traceutil/trace.go:171","msg":"trace[112091944] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1967; }","duration":"328.828969ms","start":"2026-05-06T14:11:38.769164Z","end":"2026-05-06T14:11:39.097993Z","steps":["trace[112091944] 'read index received'  (duration: 166.740447ms)","trace[112091944] 'applied index is now lower than readState.Index'  (duration: 162.085882ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:11:39.098126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.748428Z","time spent":"349.666394ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" mod_revision:1844 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" value_size:3631 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" > >"}
{"level":"warn","ts":"2026-05-06T14:11:39.098235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.037102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" ","response":"range_response_count:1 size:3746"}
{"level":"info","ts":"2026-05-06T14:11:39.098275Z","caller":"traceutil/trace.go:171","msg":"trace[1625120698] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e; range_end:; response_count:1; response_revision:1898; }","duration":"329.137927ms","start":"2026-05-06T14:11:38.769124Z","end":"2026-05-06T14:11:39.098262Z","steps":["trace[1625120698] 'agreement among raft nodes before linearized reading'  (duration: 328.989799ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:39.098316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.769112Z","time spent":"329.194571ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf724b3d-f68e-47f8-a5c4-a3264ded5c0e\" "}
{"level":"info","ts":"2026-05-06T14:11:39.098598Z","caller":"traceutil/trace.go:171","msg":"trace[710030262] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"352.986168ms","start":"2026-05-06T14:11:38.745592Z","end":"2026-05-06T14:11:39.098578Z","steps":["trace[710030262] 'process raft request'  (duration: 325.882481ms)","trace[710030262] 'compare'  (duration: 25.931221ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:11:39.098755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:38.745582Z","time spent":"353.051211ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1873 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-06T14:11:39.833794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.241639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:11:39.83389Z","caller":"traceutil/trace.go:171","msg":"trace[476794485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1899; }","duration":"178.378296ms","start":"2026-05-06T14:11:39.65549Z","end":"2026-05-06T14:11:39.833868Z","steps":["trace[476794485] 'range keys from in-memory index tree'  (duration: 178.122292ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:51.054497Z","caller":"traceutil/trace.go:171","msg":"trace[836390027] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"276.390961ms","start":"2026-05-06T14:11:50.778039Z","end":"2026-05-06T14:11:51.05443Z","steps":["trace[836390027] 'process raft request'  (duration: 275.86576ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:51.139778Z","caller":"traceutil/trace.go:171","msg":"trace[1740881410] linearizableReadLoop","detail":"{readStateIndex:2072; appliedIndex:2070; }","duration":"229.884597ms","start":"2026-05-06T14:11:50.90987Z","end":"2026-05-06T14:11:51.139754Z","steps":["trace[1740881410] 'read index received'  (duration: 144.361219ms)","trace[1740881410] 'applied index is now lower than readState.Index'  (duration: 85.522528ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:11:51.139933Z","caller":"traceutil/trace.go:171","msg":"trace[1637916604] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"359.452914ms","start":"2026-05-06T14:11:50.780468Z","end":"2026-05-06T14:11:51.13992Z","steps":["trace[1637916604] 'process raft request'  (duration: 349.302161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:51.140003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.10869ms","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-06T14:11:51.140049Z","caller":"traceutil/trace.go:171","msg":"trace[291317425] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1994; }","duration":"230.223416ms","start":"2026-05-06T14:11:50.909813Z","end":"2026-05-06T14:11:51.140037Z","steps":["trace[291317425] 'agreement among raft nodes before linearized reading'  (duration: 230.031835ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:51.140144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:50.780454Z","time spent":"359.608413ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1979 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T14:11:51.140239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.363057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T14:11:51.140306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.97497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11981"}
{"level":"info","ts":"2026-05-06T14:11:51.140784Z","caller":"traceutil/trace.go:171","msg":"trace[2092725729] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1994; }","duration":"112.483859ms","start":"2026-05-06T14:11:51.02829Z","end":"2026-05-06T14:11:51.140774Z","steps":["trace[2092725729] 'agreement among raft nodes before linearized reading'  (duration: 111.965249ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:51.140548Z","caller":"traceutil/trace.go:171","msg":"trace[1261782077] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1994; }","duration":"133.690515ms","start":"2026-05-06T14:11:51.006826Z","end":"2026-05-06T14:11:51.140516Z","steps":["trace[1261782077] 'agreement among raft nodes before linearized reading'  (duration: 133.380617ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:51.140343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.947825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:11:51.140923Z","caller":"traceutil/trace.go:171","msg":"trace[965875271] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1994; }","duration":"185.655536ms","start":"2026-05-06T14:11:50.955254Z","end":"2026-05-06T14:11:51.140909Z","steps":["trace[965875271] 'agreement among raft nodes before linearized reading'  (duration: 184.902402ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:51.140418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.440887ms","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-06T14:11:51.141025Z","caller":"traceutil/trace.go:171","msg":"trace[500200520] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1994; }","duration":"142.067143ms","start":"2026-05-06T14:11:50.99894Z","end":"2026-05-06T14:11:51.141007Z","steps":["trace[500200520] 'agreement among raft nodes before linearized reading'  (duration: 141.384724ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.166134Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307094261,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T14:11:55.174746Z","caller":"traceutil/trace.go:171","msg":"trace[1818498639] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"525.08814ms","start":"2026-05-06T14:11:54.649638Z","end":"2026-05-06T14:11:55.174726Z","steps":["trace[1818498639] 'process raft request'  (duration: 524.938231ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.174878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:54.649614Z","time spent":"525.195266ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2005 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T14:11:55.353253Z","caller":"traceutil/trace.go:171","msg":"trace[543188169] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"480.243842ms","start":"2026-05-06T14:11:54.872984Z","end":"2026-05-06T14:11:55.353228Z","steps":["trace[543188169] 'process raft request'  (duration: 480.03106ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.353413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:54.87296Z","time spent":"480.353018ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1966 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-06T14:11:55.353477Z","caller":"traceutil/trace.go:171","msg":"trace[756240776] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"286.806404ms","start":"2026-05-06T14:11:55.066646Z","end":"2026-05-06T14:11:55.353452Z","steps":["trace[756240776] 'process raft request'  (duration: 286.525557ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:55.354009Z","caller":"traceutil/trace.go:171","msg":"trace[1050334002] linearizableReadLoop","detail":"{readStateIndex:2097; appliedIndex:2093; }","duration":"688.265027ms","start":"2026-05-06T14:11:54.665728Z","end":"2026-05-06T14:11:55.353993Z","steps":["trace[1050334002] 'read index received'  (duration: 508.833771ms)","trace[1050334002] 'applied index is now lower than readState.Index'  (duration: 179.430386ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:11:55.354099Z","caller":"traceutil/trace.go:171","msg":"trace[1014316498] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"198.199806ms","start":"2026-05-06T14:11:55.155889Z","end":"2026-05-06T14:11:55.354088Z","steps":["trace[1014316498] 'process raft request'  (duration: 197.872627ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.354252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.510471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-97tmg\" ","response":"range_response_count:1 size:5854"}
{"level":"info","ts":"2026-05-06T14:11:55.35431Z","caller":"traceutil/trace.go:171","msg":"trace[1658429035] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-97tmg; range_end:; response_count:1; response_revision:2018; }","duration":"688.615799ms","start":"2026-05-06T14:11:54.66568Z","end":"2026-05-06T14:11:55.354296Z","steps":["trace[1658429035] 'agreement among raft nodes before linearized reading'  (duration: 688.462689ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.354341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:11:54.665653Z","time spent":"688.681522ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":5877,"request content":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-97tmg\" "}
{"level":"warn","ts":"2026-05-06T14:11:55.358844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.822289ms","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-06T14:11:55.358905Z","caller":"traceutil/trace.go:171","msg":"trace[203675626] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2019; }","duration":"191.889283ms","start":"2026-05-06T14:11:55.167Z","end":"2026-05-06T14:11:55.358889Z","steps":["trace[203675626] 'agreement among raft nodes before linearized reading'  (duration: 191.718543ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:11:55.359158Z","caller":"traceutil/trace.go:171","msg":"trace[421129494] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"177.757627ms","start":"2026-05-06T14:11:55.181391Z","end":"2026-05-06T14:11:55.359149Z","steps":["trace[421129494] 'process raft request'  (duration: 177.229596ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.359304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.761747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-05-06T14:11:55.359325Z","caller":"traceutil/trace.go:171","msg":"trace[1174697714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2019; }","duration":"133.82197ms","start":"2026-05-06T14:11:55.225496Z","end":"2026-05-06T14:11:55.359318Z","steps":["trace[1174697714] 'agreement among raft nodes before linearized reading'  (duration: 133.753846ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.35946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.794356ms","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-06T14:11:55.359481Z","caller":"traceutil/trace.go:171","msg":"trace[1988788014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2019; }","duration":"136.85496ms","start":"2026-05-06T14:11:55.222619Z","end":"2026-05-06T14:11:55.359474Z","steps":["trace[1988788014] 'agreement among raft nodes before linearized reading'  (duration: 136.792297ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.359605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.222002ms","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-06T14:11:55.359625Z","caller":"traceutil/trace.go:171","msg":"trace[2051759876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2019; }","duration":"137.278675ms","start":"2026-05-06T14:11:55.222341Z","end":"2026-05-06T14:11:55.359619Z","steps":["trace[2051759876] 'agreement among raft nodes before linearized reading'  (duration: 137.215771ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.359752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.142926ms","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-06T14:11:55.359771Z","caller":"traceutil/trace.go:171","msg":"trace[606890518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2019; }","duration":"160.200159ms","start":"2026-05-06T14:11:55.199565Z","end":"2026-05-06T14:11:55.359765Z","steps":["trace[606890518] 'agreement among raft nodes before linearized reading'  (duration: 160.138616ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:11:55.359898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.620668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-06T14:11:55.359918Z","caller":"traceutil/trace.go:171","msg":"trace[1600841069] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2019; }","duration":"169.66452ms","start":"2026-05-06T14:11:55.190247Z","end":"2026-05-06T14:11:55.359912Z","steps":["trace[1600841069] 'agreement among raft nodes before linearized reading'  (duration: 169.604386ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:17.477431Z","caller":"traceutil/trace.go:171","msg":"trace[218472879] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2233; }","duration":"159.571856ms","start":"2026-05-06T14:12:17.317828Z","end":"2026-05-06T14:12:17.4774Z","steps":["trace[218472879] 'read index received'  (duration: 157.772882ms)","trace[218472879] 'applied index is now lower than readState.Index'  (duration: 1.797264ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:12:17.47749Z","caller":"traceutil/trace.go:171","msg":"trace[1995347917] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"239.755364ms","start":"2026-05-06T14:12:17.237682Z","end":"2026-05-06T14:12:17.477437Z","steps":["trace[1995347917] 'process raft request'  (duration: 238.485984ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.477845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.984442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"}
{"level":"info","ts":"2026-05-06T14:12:17.47794Z","caller":"traceutil/trace.go:171","msg":"trace[1385802958] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2150; }","duration":"160.136151ms","start":"2026-05-06T14:12:17.317781Z","end":"2026-05-06T14:12:17.477918Z","steps":["trace[1385802958] 'agreement among raft nodes before linearized reading'  (duration: 159.737556ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:17.613938Z","caller":"traceutil/trace.go:171","msg":"trace[833379320] linearizableReadLoop","detail":"{readStateIndex:2237; appliedIndex:2234; }","duration":"136.397113ms","start":"2026-05-06T14:12:17.477522Z","end":"2026-05-06T14:12:17.613919Z","steps":["trace[833379320] 'read index received'  (duration: 107.234404ms)","trace[833379320] 'applied index is now lower than readState.Index'  (duration: 29.161979ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:12:17.613957Z","caller":"traceutil/trace.go:171","msg":"trace[54987994] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"181.318229ms","start":"2026-05-06T14:12:17.432607Z","end":"2026-05-06T14:12:17.613925Z","steps":["trace[54987994] 'process raft request'  (duration: 152.123299ms)","trace[54987994] 'compare'  (duration: 29.002688ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:12:17.614049Z","caller":"traceutil/trace.go:171","msg":"trace[1758955896] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"180.467486ms","start":"2026-05-06T14:12:17.433572Z","end":"2026-05-06T14:12:17.61404Z","steps":["trace[1758955896] 'process raft request'  (duration: 180.315257ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.614241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.046201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:12:17.614051Z","caller":"traceutil/trace.go:171","msg":"trace[808488449] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"180.578014ms","start":"2026-05-06T14:12:17.433419Z","end":"2026-05-06T14:12:17.613997Z","steps":["trace[808488449] 'process raft request'  (duration: 180.426924ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.614369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.233232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:12:17.614395Z","caller":"traceutil/trace.go:171","msg":"trace[361940919] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2153; }","duration":"132.287375ms","start":"2026-05-06T14:12:17.482103Z","end":"2026-05-06T14:12:17.614391Z","steps":["trace[361940919] 'agreement among raft nodes before linearized reading'  (duration: 132.186519ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.614649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.80381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-05-06T14:12:17.614684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.855282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:12:17.614702Z","caller":"traceutil/trace.go:171","msg":"trace[1124421543] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2153; }","duration":"118.887996ms","start":"2026-05-06T14:12:17.4958Z","end":"2026-05-06T14:12:17.614688Z","steps":["trace[1124421543] 'agreement among raft nodes before linearized reading'  (duration: 118.737236ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.614769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.523322ms","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-06T14:12:17.61479Z","caller":"traceutil/trace.go:171","msg":"trace[1167183819] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2153; }","duration":"129.564345ms","start":"2026-05-06T14:12:17.485222Z","end":"2026-05-06T14:12:17.614786Z","steps":["trace[1167183819] 'agreement among raft nodes before linearized reading'  (duration: 129.507951ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.614951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.182787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:12:17.614975Z","caller":"traceutil/trace.go:171","msg":"trace[214818243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2153; }","duration":"131.230879ms","start":"2026-05-06T14:12:17.483736Z","end":"2026-05-06T14:12:17.614967Z","steps":["trace[214818243] 'agreement among raft nodes before linearized reading'  (duration: 131.136463ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:17.61427Z","caller":"traceutil/trace.go:171","msg":"trace[1419860062] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2153; }","duration":"295.110934ms","start":"2026-05-06T14:12:17.319153Z","end":"2026-05-06T14:12:17.614264Z","steps":["trace[1419860062] 'agreement among raft nodes before linearized reading'  (duration: 295.002088ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:17.614706Z","caller":"traceutil/trace.go:171","msg":"trace[1512578242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2153; }","duration":"125.895314ms","start":"2026-05-06T14:12:17.488805Z","end":"2026-05-06T14:12:17.6147Z","steps":["trace[1512578242] 'agreement among raft nodes before linearized reading'  (duration: 125.82782ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:17.615364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.760136ms","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-06T14:12:17.615413Z","caller":"traceutil/trace.go:171","msg":"trace[952030067] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2153; }","duration":"110.83033ms","start":"2026-05-06T14:12:17.504571Z","end":"2026-05-06T14:12:17.615401Z","steps":["trace[952030067] 'agreement among raft nodes before linearized reading'  (duration: 110.685291ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.131194Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307094612,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T14:12:20.228368Z","caller":"traceutil/trace.go:171","msg":"trace[1387126020] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"601.237113ms","start":"2026-05-06T14:12:19.627107Z","end":"2026-05-06T14:12:20.228345Z","steps":["trace[1387126020] 'process raft request'  (duration: 601.100424ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.228534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.627084Z","time spent":"601.36025ms","remote":"127.0.0.1:58164","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:2153 > 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-06T14:12:20.240439Z","caller":"traceutil/trace.go:171","msg":"trace[791938922] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"613.193617ms","start":"2026-05-06T14:12:19.627229Z","end":"2026-05-06T14:12:20.240422Z","steps":["trace[791938922] 'process raft request'  (duration: 613.060509ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.240532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.627183Z","time spent":"613.303874ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2152 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T14:12:20.240654Z","caller":"traceutil/trace.go:171","msg":"trace[919289615] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2245; }","duration":"610.644576ms","start":"2026-05-06T14:12:19.629999Z","end":"2026-05-06T14:12:20.240644Z","steps":["trace[919289615] 'read index received'  (duration: 598.395513ms)","trace[919289615] 'applied index is now lower than readState.Index'  (duration: 12.248183ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:12:20.240927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.082757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:12:20.240968Z","caller":"traceutil/trace.go:171","msg":"trace[1763139722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2163; }","duration":"585.173283ms","start":"2026-05-06T14:12:19.655785Z","end":"2026-05-06T14:12:20.240958Z","steps":["trace[1763139722] 'agreement among raft nodes before linearized reading'  (duration: 585.113759ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.240956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.939054ms","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-06T14:12:20.241041Z","caller":"traceutil/trace.go:171","msg":"trace[239320855] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2163; }","duration":"611.079514ms","start":"2026-05-06T14:12:19.629945Z","end":"2026-05-06T14:12:20.241025Z","steps":["trace[239320855] 'agreement among raft nodes before linearized reading'  (duration: 610.86286ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.241099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.17411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:12:20.241142Z","caller":"traceutil/trace.go:171","msg":"trace[779550746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2163; }","duration":"527.253275ms","start":"2026-05-06T14:12:19.713869Z","end":"2026-05-06T14:12:20.241123Z","steps":["trace[779550746] 'agreement among raft nodes before linearized reading'  (duration: 527.157219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:20.241217Z","caller":"traceutil/trace.go:171","msg":"trace[1477638977] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"613.821626ms","start":"2026-05-06T14:12:19.62735Z","end":"2026-05-06T14:12:20.241171Z","steps":["trace[1477638977] 'process raft request'  (duration: 613.026766ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.241518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.147242ms","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-06T14:12:20.241555Z","caller":"traceutil/trace.go:171","msg":"trace[1076266217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2163; }","duration":"528.200785ms","start":"2026-05-06T14:12:19.713346Z","end":"2026-05-06T14:12:20.241547Z","steps":["trace[1076266217] 'agreement among raft nodes before linearized reading'  (duration: 527.918478ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.241542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.62734Z","time spent":"613.913432ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2151 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-06T14:12:20.241587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.713341Z","time spent":"528.240318ms","remote":"127.0.0.1:58164","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-06T14:12:20.241136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.629924Z","time spent":"611.198091ms","remote":"127.0.0.1:38188","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-06T14:12:20.241001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.655757Z","time spent":"585.238017ms","remote":"127.0.0.1:57918","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-06T14:12:20.241173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.713845Z","time spent":"527.322609ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T14:12:20.242017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.151285ms","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-06T14:12:20.242124Z","caller":"traceutil/trace.go:171","msg":"trace[2068154529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2163; }","duration":"563.315025ms","start":"2026-05-06T14:12:19.678757Z","end":"2026-05-06T14:12:20.242072Z","steps":["trace[2068154529] 'agreement among raft nodes before linearized reading'  (duration: 562.779392ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.242799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.02715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:12:20.242938Z","caller":"traceutil/trace.go:171","msg":"trace[1898004753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2163; }","duration":"530.232223ms","start":"2026-05-06T14:12:19.712664Z","end":"2026-05-06T14:12:20.242896Z","steps":["trace[1898004753] 'agreement among raft nodes before linearized reading'  (duration: 529.847708ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.243034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.712624Z","time spent":"530.398353ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:12:20.24367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.33924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:12:20.243721Z","caller":"traceutil/trace.go:171","msg":"trace[258468360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2163; }","duration":"530.444866ms","start":"2026-05-06T14:12:19.713266Z","end":"2026-05-06T14:12:20.243711Z","steps":["trace[258468360] 'agreement among raft nodes before linearized reading'  (duration: 527.963049ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.243767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.713236Z","time spent":"530.50689ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-06T14:12:20.244259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:19.678729Z","time spent":"565.44493ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T14:12:20.662185Z","caller":"traceutil/trace.go:171","msg":"trace[1288466599] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"414.513459ms","start":"2026-05-06T14:12:20.247638Z","end":"2026-05-06T14:12:20.662151Z","steps":["trace[1288466599] 'process raft request'  (duration: 403.527265ms)","trace[1288466599] 'compare'  (duration: 10.44489ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:12:20.662324Z","caller":"traceutil/trace.go:171","msg":"trace[1791847847] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"414.513128ms","start":"2026-05-06T14:12:20.24778Z","end":"2026-05-06T14:12:20.662293Z","steps":["trace[1791847847] 'process raft request'  (duration: 414.005977ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.662375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:20.247612Z","time spent":"414.692739ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2155 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-06T14:12:20.662498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:20.247772Z","time spent":"414.614904ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2157 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-06T14:12:20.66284Z","caller":"traceutil/trace.go:171","msg":"trace[1281566640] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"414.001276ms","start":"2026-05-06T14:12:20.248815Z","end":"2026-05-06T14:12:20.662816Z","steps":["trace[1281566640] 'process raft request'  (duration: 413.666044ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:20.662891Z","caller":"traceutil/trace.go:171","msg":"trace[158093341] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"414.122444ms","start":"2026-05-06T14:12:20.248739Z","end":"2026-05-06T14:12:20.662861Z","steps":["trace[158093341] 'process raft request'  (duration: 413.093349ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:20.663007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:20.248713Z","time spent":"414.229631ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2156 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-06T14:12:20.663181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:12:20.248802Z","time spent":"414.094862ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2154 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-06T14:12:48.564094Z","caller":"traceutil/trace.go:171","msg":"trace[1179158649] linearizableReadLoop","detail":"{readStateIndex:2418; appliedIndex:2415; }","duration":"187.999729ms","start":"2026-05-06T14:12:48.376071Z","end":"2026-05-06T14:12:48.564071Z","steps":["trace[1179158649] 'read index received'  (duration: 15.247377ms)","trace[1179158649] 'applied index is now lower than readState.Index'  (duration: 172.751262ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:12:48.56414Z","caller":"traceutil/trace.go:171","msg":"trace[1743883314] transaction","detail":"{read_only:false; response_revision:2327; number_of_response:1; }","duration":"229.958961ms","start":"2026-05-06T14:12:48.334153Z","end":"2026-05-06T14:12:48.564112Z","steps":["trace[1743883314] 'process raft request'  (duration: 229.873805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:48.564393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.304049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:12:48.564481Z","caller":"traceutil/trace.go:171","msg":"trace[460589124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2327; }","duration":"188.417437ms","start":"2026-05-06T14:12:48.376042Z","end":"2026-05-06T14:12:48.56446Z","steps":["trace[460589124] 'agreement among raft nodes before linearized reading'  (duration: 188.16922ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:48.564462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.232405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"}
{"level":"info","ts":"2026-05-06T14:12:48.564539Z","caller":"traceutil/trace.go:171","msg":"trace[1274395712] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2327; }","duration":"132.356994ms","start":"2026-05-06T14:12:48.432168Z","end":"2026-05-06T14:12:48.564525Z","steps":["trace[1274395712] 'agreement among raft nodes before linearized reading'  (duration: 132.125048ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:12:48.564124Z","caller":"traceutil/trace.go:171","msg":"trace[334949226] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"230.736472ms","start":"2026-05-06T14:12:48.333355Z","end":"2026-05-06T14:12:48.564091Z","steps":["trace[334949226] 'process raft request'  (duration: 197.816758ms)","trace[334949226] 'compare'  (duration: 32.738452ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:12:48.914505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.879669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:12:48.914714Z","caller":"traceutil/trace.go:171","msg":"trace[1599417423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2328; }","duration":"130.198251ms","start":"2026-05-06T14:12:48.784495Z","end":"2026-05-06T14:12:48.914693Z","steps":["trace[1599417423] 'range keys from in-memory index tree'  (duration: 129.682146ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:48.914722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.58295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:12:48.914881Z","caller":"traceutil/trace.go:171","msg":"trace[109883445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2328; }","duration":"114.789803ms","start":"2026-05-06T14:12:48.800066Z","end":"2026-05-06T14:12:48.914855Z","steps":["trace[109883445] 'range keys from in-memory index tree'  (duration: 114.443821ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:48.914547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.864993ms","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-06T14:12:48.915138Z","caller":"traceutil/trace.go:171","msg":"trace[434639673] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2328; }","duration":"119.475162ms","start":"2026-05-06T14:12:48.795636Z","end":"2026-05-06T14:12:48.915111Z","steps":["trace[434639673] 'range keys from in-memory index tree'  (duration: 118.704551ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:12:48.914616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.983604ms","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-06T14:12:48.915328Z","caller":"traceutil/trace.go:171","msg":"trace[2137795918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2328; }","duration":"113.741203ms","start":"2026-05-06T14:12:48.80157Z","end":"2026-05-06T14:12:48.915311Z","steps":["trace[2137795918] 'range keys from in-memory index tree'  (duration: 112.826433ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:20.75744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.663743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:13:20.757534Z","caller":"traceutil/trace.go:171","msg":"trace[1460684256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2601; }","duration":"100.816513ms","start":"2026-05-06T14:13:20.656698Z","end":"2026-05-06T14:13:20.757515Z","steps":["trace[1460684256] 'range keys from in-memory index tree'  (duration: 100.572547ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:36.19953Z","caller":"traceutil/trace.go:171","msg":"trace[878718754] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"153.28666ms","start":"2026-05-06T14:13:36.046211Z","end":"2026-05-06T14:13:36.199497Z","steps":["trace[878718754] 'process raft request'  (duration: 153.110648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:42.230248Z","caller":"traceutil/trace.go:171","msg":"trace[1419314859] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"377.680453ms","start":"2026-05-06T14:13:41.852525Z","end":"2026-05-06T14:13:42.230205Z","steps":["trace[1419314859] 'process raft request'  (duration: 377.438655ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:42.230433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:41.852493Z","time spent":"377.844615ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2705 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T14:13:42.543705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.459855ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307095940 > lease_revoke:<id:5aa09dfd9f003096>","response":"size:28"}
{"level":"warn","ts":"2026-05-06T14:13:42.543851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.057231ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:13:42.543967Z","caller":"traceutil/trace.go:171","msg":"trace[78534338] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2717; }","duration":"299.184535ms","start":"2026-05-06T14:13:42.244764Z","end":"2026-05-06T14:13:42.543949Z","steps":["trace[78534338] 'range keys from in-memory index tree'  (duration: 299.041852ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:42.882879Z","caller":"traceutil/trace.go:171","msg":"trace[1618096650] linearizableReadLoop","detail":"{readStateIndex:2822; appliedIndex:2821; }","duration":"227.421224ms","start":"2026-05-06T14:13:42.655434Z","end":"2026-05-06T14:13:42.882855Z","steps":["trace[1618096650] 'read index received'  (duration: 227.263142ms)","trace[1618096650] 'applied index is now lower than readState.Index'  (duration: 156.972µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:13:42.883196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.757749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:13:42.883313Z","caller":"traceutil/trace.go:171","msg":"trace[1125648761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2718; }","duration":"227.93537ms","start":"2026-05-06T14:13:42.655367Z","end":"2026-05-06T14:13:42.883303Z","steps":["trace[1125648761] 'agreement among raft nodes before linearized reading'  (duration: 227.772567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:42.883162Z","caller":"traceutil/trace.go:171","msg":"trace[816771883] transaction","detail":"{read_only:false; response_revision:2718; number_of_response:1; }","duration":"297.817812ms","start":"2026-05-06T14:13:42.585315Z","end":"2026-05-06T14:13:42.883133Z","steps":["trace[816771883] 'process raft request'  (duration: 297.366745ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.383688Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307095946,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T14:13:43.648313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.262582ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307095943 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2708 > 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-06T14:13:43.649064Z","caller":"traceutil/trace.go:171","msg":"trace[725426495] linearizableReadLoop","detail":"{readStateIndex:2825; appliedIndex:2822; }","duration":"765.935542ms","start":"2026-05-06T14:13:42.883117Z","end":"2026-05-06T14:13:43.649053Z","steps":["trace[725426495] 'read index received'  (duration: 544.882008ms)","trace[725426495] 'applied index is now lower than readState.Index'  (duration: 221.052944ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:13:43.649177Z","caller":"traceutil/trace.go:171","msg":"trace[548713720] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"986.437748ms","start":"2026-05-06T14:13:42.662727Z","end":"2026-05-06T14:13:43.649165Z","steps":["trace[548713720] 'process raft request'  (duration: 765.237541ms)","trace[548713720] 'compare'  (duration: 220.037344ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:13:43.649275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:42.662709Z","time spent":"986.527614ms","remote":"127.0.0.1:58164","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:2708 > 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-06T14:13:43.649352Z","caller":"traceutil/trace.go:171","msg":"trace[1432886400] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"801.625957ms","start":"2026-05-06T14:13:42.847706Z","end":"2026-05-06T14:13:43.649332Z","steps":["trace[1432886400] 'process raft request'  (duration: 801.316402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:43.649396Z","caller":"traceutil/trace.go:171","msg":"trace[1346991303] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"803.640247ms","start":"2026-05-06T14:13:42.845739Z","end":"2026-05-06T14:13:43.649379Z","steps":["trace[1346991303] 'process raft request'  (duration: 803.206777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.649461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:42.847693Z","time spent":"801.708963ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2709 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-06T14:13:43.649488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:42.845713Z","time spent":"803.730733ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2710 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T14:13:43.649609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.269799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-06T14:13:43.649633Z","caller":"traceutil/trace.go:171","msg":"trace[101106998] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2721; }","duration":"427.335476ms","start":"2026-05-06T14:13:43.222292Z","end":"2026-05-06T14:13:43.649627Z","steps":["trace[101106998] 'agreement among raft nodes before linearized reading'  (duration: 427.2432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.649648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:43.222269Z","time spent":"427.375684ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-06T14:13:43.649613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.091116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-06T14:13:43.649662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.260341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:13:43.649695Z","caller":"traceutil/trace.go:171","msg":"trace[65902651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2721; }","duration":"457.317459ms","start":"2026-05-06T14:13:43.192367Z","end":"2026-05-06T14:13:43.649684Z","steps":["trace[65902651] 'agreement among raft nodes before linearized reading'  (duration: 457.206684ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.64969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.025568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:13:43.6497Z","caller":"traceutil/trace.go:171","msg":"trace[741550513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2721; }","duration":"787.251757ms","start":"2026-05-06T14:13:42.862431Z","end":"2026-05-06T14:13:43.649682Z","steps":["trace[741550513] 'agreement among raft nodes before linearized reading'  (duration: 787.043597ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:43.649758Z","caller":"traceutil/trace.go:171","msg":"trace[2134704804] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2721; }","duration":"732.115844ms","start":"2026-05-06T14:13:42.917617Z","end":"2026-05-06T14:13:43.649733Z","steps":["trace[2134704804] 'agreement among raft nodes before linearized reading'  (duration: 732.0095ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.649768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:42.862406Z","time spent":"787.341903ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-06T14:13:43.649797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:43.192349Z","time spent":"457.401715ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T14:13:43.649822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:42.917602Z","time spent":"732.208ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":6,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T14:13:43.649864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.112534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:13:43.64989Z","caller":"traceutil/trace.go:171","msg":"trace[1428730120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2721; }","duration":"432.171451ms","start":"2026-05-06T14:13:43.217712Z","end":"2026-05-06T14:13:43.649884Z","steps":["trace[1428730120] 'agreement among raft nodes before linearized reading'  (duration: 432.115184ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.649906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:43.217688Z","time spent":"432.214099ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T14:13:43.649577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.078684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T14:13:43.64995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.941811ms","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-06T14:13:43.649952Z","caller":"traceutil/trace.go:171","msg":"trace[2122450479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2721; }","duration":"765.505333ms","start":"2026-05-06T14:13:42.884433Z","end":"2026-05-06T14:13:43.649938Z","steps":["trace[2122450479] 'agreement among raft nodes before linearized reading'  (duration: 765.047266ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:13:43.649983Z","caller":"traceutil/trace.go:171","msg":"trace[709038254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2721; }","duration":"424.996249ms","start":"2026-05-06T14:13:43.224978Z","end":"2026-05-06T14:13:43.649974Z","steps":["trace[709038254] 'agreement among raft nodes before linearized reading'  (duration: 424.911343ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:13:43.649991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:42.884422Z","time spent":"765.559251ms","remote":"127.0.0.1:57918","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-06T14:13:43.650013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:13:43.224968Z","time spent":"425.039587ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T14:14:38.198578Z","caller":"traceutil/trace.go:171","msg":"trace[1208666001] linearizableReadLoop","detail":"{readStateIndex:3124; appliedIndex:3123; }","duration":"104.91165ms","start":"2026-05-06T14:14:38.093642Z","end":"2026-05-06T14:14:38.198553Z","steps":["trace[1208666001] 'read index received'  (duration: 104.695592ms)","trace[1208666001] 'applied index is now lower than readState.Index'  (duration: 215.018µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:14:38.198704Z","caller":"traceutil/trace.go:171","msg":"trace[1252613543] transaction","detail":"{read_only:false; response_revision:3008; number_of_response:1; }","duration":"114.815966ms","start":"2026-05-06T14:14:38.083878Z","end":"2026-05-06T14:14:38.198694Z","steps":["trace[1252613543] 'process raft request'  (duration: 114.42495ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:14:38.198919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.258116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T14:14:38.19895Z","caller":"traceutil/trace.go:171","msg":"trace[1311178768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3008; }","duration":"105.325665ms","start":"2026-05-06T14:14:38.093614Z","end":"2026-05-06T14:14:38.19894Z","steps":["trace[1311178768] 'agreement among raft nodes before linearized reading'  (duration: 105.203097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:14:38.199326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.405736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-05-06T14:14:38.199274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.96307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:14:38.199375Z","caller":"traceutil/trace.go:171","msg":"trace[1160133830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3008; }","duration":"104.476204ms","start":"2026-05-06T14:14:38.094888Z","end":"2026-05-06T14:14:38.199365Z","steps":["trace[1160133830] 'agreement among raft nodes before linearized reading'  (duration: 104.363376ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:14:38.199374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.315676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:14:38.199402Z","caller":"traceutil/trace.go:171","msg":"trace[788504740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3008; }","duration":"105.127588ms","start":"2026-05-06T14:14:38.09425Z","end":"2026-05-06T14:14:38.199378Z","steps":["trace[788504740] 'agreement among raft nodes before linearized reading'  (duration: 104.865081ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:14:38.199427Z","caller":"traceutil/trace.go:171","msg":"trace[343147394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3008; }","duration":"104.388196ms","start":"2026-05-06T14:14:38.095026Z","end":"2026-05-06T14:14:38.199414Z","steps":["trace[343147394] 'agreement among raft nodes before linearized reading'  (duration: 104.229138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:14:38.324572Z","caller":"traceutil/trace.go:171","msg":"trace[1732845697] transaction","detail":"{read_only:false; response_revision:3009; number_of_response:1; }","duration":"121.195964ms","start":"2026-05-06T14:14:38.203356Z","end":"2026-05-06T14:14:38.324552Z","steps":["trace[1732845697] 'process raft request'  (duration: 102.33667ms)","trace[1732845697] 'compare'  (duration: 18.600277ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:14:38.324838Z","caller":"traceutil/trace.go:171","msg":"trace[1886633973] transaction","detail":"{read_only:false; response_revision:3010; number_of_response:1; }","duration":"120.243715ms","start":"2026-05-06T14:14:38.204581Z","end":"2026-05-06T14:14:38.324824Z","steps":["trace[1886633973] 'process raft request'  (duration: 120.089467ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:14:38.325007Z","caller":"traceutil/trace.go:171","msg":"trace[1145958396] transaction","detail":"{read_only:false; response_revision:3011; number_of_response:1; }","duration":"120.260425ms","start":"2026-05-06T14:14:38.204736Z","end":"2026-05-06T14:14:38.324997Z","steps":["trace[1145958396] 'process raft request'  (duration: 120.035088ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:14:38.32512Z","caller":"traceutil/trace.go:171","msg":"trace[1198500473] transaction","detail":"{read_only:false; response_revision:3012; number_of_response:1; }","duration":"120.224166ms","start":"2026-05-06T14:14:38.204886Z","end":"2026-05-06T14:14:38.32511Z","steps":["trace[1198500473] 'process raft request'  (duration: 120.051028ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:16:05.024001Z","caller":"traceutil/trace.go:171","msg":"trace[681054562] transaction","detail":"{read_only:false; response_revision:3555; number_of_response:1; }","duration":"115.662755ms","start":"2026-05-06T14:16:04.908306Z","end":"2026-05-06T14:16:05.023969Z","steps":["trace[681054562] 'process raft request'  (duration: 42.02161ms)","trace[681054562] 'compare'  (duration: 73.45293ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:05.024196Z","caller":"traceutil/trace.go:171","msg":"trace[807350362] transaction","detail":"{read_only:false; response_revision:3556; number_of_response:1; }","duration":"115.372389ms","start":"2026-05-06T14:16:04.908779Z","end":"2026-05-06T14:16:05.024151Z","steps":["trace[807350362] 'process raft request'  (duration: 115.143384ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:16:18.146747Z","caller":"traceutil/trace.go:171","msg":"trace[1425437635] transaction","detail":"{read_only:false; response_revision:3623; number_of_response:1; }","duration":"117.987932ms","start":"2026-05-06T14:16:18.028723Z","end":"2026-05-06T14:16:18.14671Z","steps":["trace[1425437635] 'process raft request'  (duration: 101.128223ms)","trace[1425437635] 'compare'  (duration: 16.707775ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:18.56974Z","caller":"traceutil/trace.go:171","msg":"trace[156253331] transaction","detail":"{read_only:false; response_revision:3626; number_of_response:1; }","duration":"108.237237ms","start":"2026-05-06T14:16:18.461475Z","end":"2026-05-06T14:16:18.569712Z","steps":["trace[156253331] 'process raft request'  (duration: 13.156032ms)","trace[156253331] 'compare'  (duration: 94.85547ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:18.569943Z","caller":"traceutil/trace.go:171","msg":"trace[1660447467] transaction","detail":"{read_only:false; response_revision:3627; number_of_response:1; }","duration":"105.63064ms","start":"2026-05-06T14:16:18.464285Z","end":"2026-05-06T14:16:18.569916Z","steps":["trace[1660447467] 'process raft request'  (duration: 105.380263ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:16:22.748782Z","caller":"traceutil/trace.go:171","msg":"trace[451440388] transaction","detail":"{read_only:false; response_revision:3646; number_of_response:1; }","duration":"101.788749ms","start":"2026-05-06T14:16:22.646966Z","end":"2026-05-06T14:16:22.748755Z","steps":["trace[451440388] 'process raft request'  (duration: 68.853019ms)","trace[451440388] 'compare'  (duration: 32.828707ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:29.476983Z","caller":"traceutil/trace.go:171","msg":"trace[224201814] transaction","detail":"{read_only:false; response_revision:3688; number_of_response:1; }","duration":"109.386361ms","start":"2026-05-06T14:16:29.367578Z","end":"2026-05-06T14:16:29.476965Z","steps":["trace[224201814] 'process raft request'  (duration: 109.258218ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:16:41.392364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.724966ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307098729 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:3740 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T14:16:41.392695Z","caller":"traceutil/trace.go:171","msg":"trace[1025430595] transaction","detail":"{read_only:false; response_revision:3780; number_of_response:1; }","duration":"235.317958ms","start":"2026-05-06T14:16:41.157346Z","end":"2026-05-06T14:16:41.392664Z","steps":["trace[1025430595] 'process raft request'  (duration: 74.963191ms)","trace[1025430595] 'compare'  (duration: 159.320344ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:41.392822Z","caller":"traceutil/trace.go:171","msg":"trace[1656484465] linearizableReadLoop","detail":"{readStateIndex:3927; appliedIndex:3925; }","duration":"160.099239ms","start":"2026-05-06T14:16:41.232701Z","end":"2026-05-06T14:16:41.3928Z","steps":["trace[1656484465] 'read index received'  (duration: 57.890698ms)","trace[1656484465] 'applied index is now lower than readState.Index'  (duration: 102.207381ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:41.392921Z","caller":"traceutil/trace.go:171","msg":"trace[63269139] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3781; }","duration":"176.846032ms","start":"2026-05-06T14:16:41.216054Z","end":"2026-05-06T14:16:41.3929Z","steps":["trace[63269139] 'process raft request'  (duration: 176.649676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:16:41.393054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.439624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-06T14:16:41.39307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.367478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:16:41.393123Z","caller":"traceutil/trace.go:171","msg":"trace[1401821271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3781; }","duration":"160.45731ms","start":"2026-05-06T14:16:41.232648Z","end":"2026-05-06T14:16:41.393106Z","steps":["trace[1401821271] 'agreement among raft nodes before linearized reading'  (duration: 160.286285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:16:41.393088Z","caller":"traceutil/trace.go:171","msg":"trace[967496950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3781; }","duration":"156.503787ms","start":"2026-05-06T14:16:41.236578Z","end":"2026-05-06T14:16:41.393082Z","steps":["trace[967496950] 'agreement among raft nodes before linearized reading'  (duration: 156.382553ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:16:41.50775Z","caller":"traceutil/trace.go:171","msg":"trace[719531773] transaction","detail":"{read_only:false; response_revision:3783; number_of_response:1; }","duration":"110.053307ms","start":"2026-05-06T14:16:41.397674Z","end":"2026-05-06T14:16:41.507727Z","steps":["trace[719531773] 'process raft request'  (duration: 97.118922ms)","trace[719531773] 'compare'  (duration: 12.669767ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:16:41.507742Z","caller":"traceutil/trace.go:171","msg":"trace[13041091] transaction","detail":"{read_only:false; response_revision:3784; number_of_response:1; }","duration":"106.399062ms","start":"2026-05-06T14:16:41.401318Z","end":"2026-05-06T14:16:41.507717Z","steps":["trace[13041091] 'process raft request'  (duration: 106.298969ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:17:38.100945Z","caller":"traceutil/trace.go:171","msg":"trace[642682207] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"160.895189ms","start":"2026-05-06T14:17:37.940029Z","end":"2026-05-06T14:17:38.100924Z","steps":["trace[642682207] 'process raft request'  (duration: 160.700891ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:17:38.805064Z","caller":"traceutil/trace.go:171","msg":"trace[1560222671] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"139.634172ms","start":"2026-05-06T14:17:38.665386Z","end":"2026-05-06T14:17:38.80502Z","steps":["trace[1560222671] 'process raft request'  (duration: 50.959503ms)","trace[1560222671] 'compare'  (duration: 88.347356ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:17:39.01602Z","caller":"traceutil/trace.go:171","msg":"trace[1687854776] linearizableReadLoop","detail":"{readStateIndex:4824; appliedIndex:4823; }","duration":"133.068597ms","start":"2026-05-06T14:17:38.88289Z","end":"2026-05-06T14:17:39.015959Z","steps":["trace[1687854776] 'read index received'  (duration: 80.296719ms)","trace[1687854776] 'applied index is now lower than readState.Index'  (duration: 52.770218ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:17:39.016174Z","caller":"traceutil/trace.go:171","msg":"trace[1750283483] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"136.611071ms","start":"2026-05-06T14:17:38.879533Z","end":"2026-05-06T14:17:39.016144Z","steps":["trace[1750283483] 'process raft request'  (duration: 83.684466ms)","trace[1750283483] 'compare'  (duration: 52.027188ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:17:39.016368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.453423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"}
{"level":"info","ts":"2026-05-06T14:17:39.016439Z","caller":"traceutil/trace.go:171","msg":"trace[1252005544] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4645; }","duration":"133.566458ms","start":"2026-05-06T14:17:38.882858Z","end":"2026-05-06T14:17:39.016425Z","steps":["trace[1252005544] 'agreement among raft nodes before linearized reading'  (duration: 133.269296ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:17:39.281809Z","caller":"traceutil/trace.go:171","msg":"trace[953721860] transaction","detail":"{read_only:false; response_revision:4646; number_of_response:1; }","duration":"224.932322ms","start":"2026-05-06T14:17:39.056835Z","end":"2026-05-06T14:17:39.281767Z","steps":["trace[953721860] 'process raft request'  (duration: 190.206584ms)","trace[953721860] 'compare'  (duration: 34.507669ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:17:42.993883Z","caller":"traceutil/trace.go:171","msg":"trace[1295029518] linearizableReadLoop","detail":"{readStateIndex:4909; appliedIndex:4908; }","duration":"303.977677ms","start":"2026-05-06T14:17:42.689881Z","end":"2026-05-06T14:17:42.993858Z","steps":["trace[1295029518] 'read index received'  (duration: 303.713056ms)","trace[1295029518] 'applied index is now lower than readState.Index'  (duration: 263.411µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:17:42.994134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.232549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30cbc211-8570-4ede-aa5d-bb3f9c909c54\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-05-06T14:17:42.994193Z","caller":"traceutil/trace.go:171","msg":"trace[704469695] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-30cbc211-8570-4ede-aa5d-bb3f9c909c54; range_end:; response_count:1; response_revision:4728; }","duration":"304.347113ms","start":"2026-05-06T14:17:42.689832Z","end":"2026-05-06T14:17:42.99418Z","steps":["trace[704469695] 'agreement among raft nodes before linearized reading'  (duration: 304.127624ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:42.994234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:42.689814Z","time spent":"304.409566ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30cbc211-8570-4ede-aa5d-bb3f9c909c54\" "}
{"level":"info","ts":"2026-05-06T14:17:42.994773Z","caller":"traceutil/trace.go:171","msg":"trace[233538945] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"363.077522ms","start":"2026-05-06T14:17:42.631675Z","end":"2026-05-06T14:17:42.994753Z","steps":["trace[233538945] 'process raft request'  (duration: 361.985707ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:42.994891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:42.631645Z","time spent":"363.174507ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4655 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T14:17:45.253227Z","caller":"traceutil/trace.go:171","msg":"trace[785754765] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"252.842236ms","start":"2026-05-06T14:17:45.000361Z","end":"2026-05-06T14:17:45.253203Z","steps":["trace[785754765] 'process raft request'  (duration: 252.68642ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:17:45.268032Z","caller":"traceutil/trace.go:171","msg":"trace[355697990] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"216.37701ms","start":"2026-05-06T14:17:45.051632Z","end":"2026-05-06T14:17:45.268009Z","steps":["trace[355697990] 'process raft request'  (duration: 216.213183ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:57.905734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307101212,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T14:17:58.406767Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393172307101212,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T14:17:58.439428Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.147065365s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-06T14:17:58.439915Z","caller":"traceutil/trace.go:171","msg":"trace[1779297413] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"1.147682521s","start":"2026-05-06T14:17:57.292204Z","end":"2026-05-06T14:17:58.439887Z","steps":["trace[1779297413] 'process raft request'  (duration: 1.147485333s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.440113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.292179Z","time spent":"1.147825577s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4882 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T14:17:58.452483Z","caller":"traceutil/trace.go:171","msg":"trace[273343297] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"1.146087064s","start":"2026-05-06T14:17:57.306371Z","end":"2026-05-06T14:17:58.452458Z","steps":["trace[273343297] 'process raft request'  (duration: 1.145923347s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.452848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.306353Z","time spent":"1.146299153s","remote":"127.0.0.1:58164","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:4883 > 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-06T14:17:58.453004Z","caller":"traceutil/trace.go:171","msg":"trace[561361043] linearizableReadLoop","detail":"{readStateIndex:5101; appliedIndex:5098; }","duration":"1.047887429s","start":"2026-05-06T14:17:57.405083Z","end":"2026-05-06T14:17:58.452971Z","steps":["trace[561361043] 'read index received'  (duration: 1.034796805s)","trace[561361043] 'applied index is now lower than readState.Index'  (duration: 13.089864ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:17:58.453026Z","caller":"traceutil/trace.go:171","msg":"trace[1116958104] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"1.105193734s","start":"2026-05-06T14:17:57.34782Z","end":"2026-05-06T14:17:58.453013Z","steps":["trace[1116958104] 'process raft request'  (duration: 1.105051198s)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:17:58.453018Z","caller":"traceutil/trace.go:171","msg":"trace[980173622] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"1.106300252s","start":"2026-05-06T14:17:57.346704Z","end":"2026-05-06T14:17:58.453005Z","steps":["trace[980173622] 'process raft request'  (duration: 1.105722868s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.453119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.347808Z","time spent":"1.105253537s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4885 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-06T14:17:58.453125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.346671Z","time spent":"1.106427827s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4884 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T14:17:58.453255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048176302s","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-06T14:17:58.453285Z","caller":"traceutil/trace.go:171","msg":"trace[1919702257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4913; }","duration":"1.048258016s","start":"2026-05-06T14:17:57.40502Z","end":"2026-05-06T14:17:58.453278Z","steps":["trace[1919702257] 'agreement among raft nodes before linearized reading'  (duration: 1.048060067s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.453306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.404997Z","time spent":"1.048303698s","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-06T14:17:58.453335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.792607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"info","ts":"2026-05-06T14:17:58.453379Z","caller":"traceutil/trace.go:171","msg":"trace[1325785215] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4913; }","duration":"384.86642ms","start":"2026-05-06T14:17:58.0685Z","end":"2026-05-06T14:17:58.453366Z","steps":["trace[1325785215] 'agreement among raft nodes before linearized reading'  (duration: 384.762315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.453413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:58.068481Z","time spent":"384.925672ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-05-06T14:17:58.453431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.374907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:17:58.453447Z","caller":"traceutil/trace.go:171","msg":"trace[1949916244] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4913; }","duration":"342.43866ms","start":"2026-05-06T14:17:58.111004Z","end":"2026-05-06T14:17:58.453442Z","steps":["trace[1949916244] 'agreement among raft nodes before linearized reading'  (duration: 342.356587ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.453467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:58.110981Z","time spent":"342.481742ms","remote":"127.0.0.1:58106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":69,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T14:17:58.45358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.837471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-05-06T14:17:58.453618Z","caller":"traceutil/trace.go:171","msg":"trace[1852280379] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4913; }","duration":"558.872232ms","start":"2026-05-06T14:17:57.894735Z","end":"2026-05-06T14:17:58.453607Z","steps":["trace[1852280379] 'agreement among raft nodes before linearized reading'  (duration: 558.770838ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.453607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.012590021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-05-06T14:17:58.453651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.894697Z","time spent":"558.947376ms","remote":"127.0.0.1:58054","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-06T14:17:58.453687Z","caller":"traceutil/trace.go:171","msg":"trace[667239134] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4913; }","duration":"1.012710856s","start":"2026-05-06T14:17:57.440945Z","end":"2026-05-06T14:17:58.453655Z","steps":["trace[667239134] 'agreement among raft nodes before linearized reading'  (duration: 1.012319919s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.453739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.440915Z","time spent":"1.01281191s","remote":"127.0.0.1:58164","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-06T14:17:58.453871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.664098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-06T14:17:58.45389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.000867ms","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-06T14:17:58.453908Z","caller":"traceutil/trace.go:171","msg":"trace[1909070704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4913; }","duration":"523.72379ms","start":"2026-05-06T14:17:57.930175Z","end":"2026-05-06T14:17:58.453899Z","steps":["trace[1909070704] 'agreement among raft nodes before linearized reading'  (duration: 523.636017ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.45394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.930156Z","time spent":"523.778133ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-06T14:17:58.45391Z","caller":"traceutil/trace.go:171","msg":"trace[157437168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4913; }","duration":"575.06532ms","start":"2026-05-06T14:17:57.878839Z","end":"2026-05-06T14:17:58.453904Z","steps":["trace[157437168] 'agreement among raft nodes before linearized reading'  (duration: 575.007547ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.454002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.878819Z","time spent":"575.177245ms","remote":"127.0.0.1:58164","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-06T14:17:58.454002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.186187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:17:58.454066Z","caller":"traceutil/trace.go:171","msg":"trace[870891176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4913; }","duration":"798.318454ms","start":"2026-05-06T14:17:57.655733Z","end":"2026-05-06T14:17:58.454051Z","steps":["trace[870891176] 'agreement among raft nodes before linearized reading'  (duration: 798.173498ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.454104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.655689Z","time spent":"798.410197ms","remote":"127.0.0.1:57914","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-06T14:17:58.454165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.412764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-06T14:17:58.454328Z","caller":"traceutil/trace.go:171","msg":"trace[1693068930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4913; }","duration":"542.629804ms","start":"2026-05-06T14:17:57.911673Z","end":"2026-05-06T14:17:58.454303Z","steps":["trace[1693068930] 'agreement among raft nodes before linearized reading'  (duration: 542.224416ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:17:58.454393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:17:57.911665Z","time spent":"542.715007ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T14:17:58.858658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.443792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:17:58.858764Z","caller":"traceutil/trace.go:171","msg":"trace[2366941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4919; }","duration":"202.645861ms","start":"2026-05-06T14:17:58.656098Z","end":"2026-05-06T14:17:58.858744Z","steps":["trace[2366941] 'range keys from in-memory index tree'  (duration: 202.316795ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:09.649789Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855}
{"level":"info","ts":"2026-05-06T14:19:09.741872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"90.647215ms","hash":2693708163,"current-db-size-bytes":53583872,"current-db-size":"54 MB","current-db-size-in-use-bytes":28966912,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-06T14:19:09.741955Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2693708163,"revision":2855,"compact-revision":-1}
{"level":"info","ts":"2026-05-06T14:19:26.013587Z","caller":"traceutil/trace.go:171","msg":"trace[1960114744] linearizableReadLoop","detail":"{readStateIndex:5828; appliedIndex:5827; }","duration":"192.200215ms","start":"2026-05-06T14:19:25.821363Z","end":"2026-05-06T14:19:26.013563Z","steps":["trace[1960114744] 'read index received'  (duration: 191.981814ms)","trace[1960114744] 'applied index is now lower than readState.Index'  (duration: 217.491µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:19:26.013705Z","caller":"traceutil/trace.go:171","msg":"trace[763644996] transaction","detail":"{read_only:false; response_revision:5620; number_of_response:1; }","duration":"237.10383ms","start":"2026-05-06T14:19:25.776588Z","end":"2026-05-06T14:19:26.013692Z","steps":["trace[763644996] 'process raft request'  (duration: 236.830137ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:26.013933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.822596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"warn","ts":"2026-05-06T14:19:26.013978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.801845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"warn","ts":"2026-05-06T14:19:26.013983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.586244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T14:19:26.014041Z","caller":"traceutil/trace.go:171","msg":"trace[1740131275] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5620; }","duration":"187.89831ms","start":"2026-05-06T14:19:25.826125Z","end":"2026-05-06T14:19:26.014023Z","steps":["trace[1740131275] 'agreement among raft nodes before linearized reading'  (duration: 187.612535ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:26.014011Z","caller":"traceutil/trace.go:171","msg":"trace[1879088779] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5620; }","duration":"148.958023ms","start":"2026-05-06T14:19:25.865033Z","end":"2026-05-06T14:19:26.013991Z","steps":["trace[1879088779] 'agreement among raft nodes before linearized reading'  (duration: 148.803635ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:26.014071Z","caller":"traceutil/trace.go:171","msg":"trace[2103512914] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5620; }","duration":"192.723371ms","start":"2026-05-06T14:19:25.821327Z","end":"2026-05-06T14:19:26.01405Z","steps":["trace[2103512914] 'agreement among raft nodes before linearized reading'  (duration: 192.478769ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:26.997777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:19:26.649521Z","time spent":"348.247024ms","remote":"127.0.0.1:57938","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-05-06T14:19:27.200554Z","caller":"traceutil/trace.go:171","msg":"trace[294200643] transaction","detail":"{read_only:false; response_revision:5625; number_of_response:1; }","duration":"438.433211ms","start":"2026-05-06T14:19:26.762085Z","end":"2026-05-06T14:19:27.200518Z","steps":["trace[294200643] 'process raft request'  (duration: 400.554683ms)","trace[294200643] 'compare'  (duration: 37.581372ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:19:27.200867Z","caller":"traceutil/trace.go:171","msg":"trace[135742593] transaction","detail":"{read_only:false; response_revision:5626; number_of_response:1; }","duration":"427.797105ms","start":"2026-05-06T14:19:26.77304Z","end":"2026-05-06T14:19:27.200837Z","steps":["trace[135742593] 'process raft request'  (duration: 427.397876ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:27.200916Z","caller":"traceutil/trace.go:171","msg":"trace[1548584233] linearizableReadLoop","detail":"{readStateIndex:5835; appliedIndex:5832; }","duration":"402.790168ms","start":"2026-05-06T14:19:26.798105Z","end":"2026-05-06T14:19:27.200895Z","steps":["trace[1548584233] 'read index received'  (duration: 121.868429ms)","trace[1548584233] 'applied index is now lower than readState.Index'  (duration: 280.920289ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:19:27.201093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:19:26.773027Z","time spent":"427.904261ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5605 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-06T14:19:27.201159Z","caller":"traceutil/trace.go:171","msg":"trace[969311054] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"401.484523ms","start":"2026-05-06T14:19:26.799599Z","end":"2026-05-06T14:19:27.201083Z","steps":["trace[969311054] 'process raft request'  (duration: 401.23655ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:27.20125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.138655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T14:19:27.202023Z","caller":"traceutil/trace.go:171","msg":"trace[995407249] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5628; }","duration":"403.939676ms","start":"2026-05-06T14:19:26.798058Z","end":"2026-05-06T14:19:27.201997Z","steps":["trace[995407249] 'agreement among raft nodes before linearized reading'  (duration: 403.151366ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:27.201321Z","caller":"traceutil/trace.go:171","msg":"trace[1467790189] transaction","detail":"{read_only:false; response_revision:5627; number_of_response:1; }","duration":"402.192308ms","start":"2026-05-06T14:19:26.799115Z","end":"2026-05-06T14:19:27.201308Z","steps":["trace[1467790189] 'process raft request'  (duration: 401.622039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:27.202087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:19:26.762059Z","time spent":"438.581938ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5603 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T14:19:27.202116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:19:26.798035Z","time spent":"404.044411ms","remote":"127.0.0.1:38188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T14:19:27.202198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:19:26.799101Z","time spent":"403.045451ms","remote":"127.0.0.1:58164","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:5611 > 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-06T14:19:27.202235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T14:19:26.799584Z","time spent":"402.553797ms","remote":"127.0.0.1:58164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5609 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-06T14:19:27.280481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.157689ms","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-06T14:19:27.28055Z","caller":"traceutil/trace.go:171","msg":"trace[1039700355] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5629; }","duration":"292.273195ms","start":"2026-05-06T14:19:26.988261Z","end":"2026-05-06T14:19:27.280534Z","steps":["trace[1039700355] 'agreement among raft nodes before linearized reading'  (duration: 292.065594ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:27.28075Z","caller":"traceutil/trace.go:171","msg":"trace[163668365] transaction","detail":"{read_only:false; response_revision:5629; number_of_response:1; }","duration":"281.872161ms","start":"2026-05-06T14:19:26.998868Z","end":"2026-05-06T14:19:27.28074Z","steps":["trace[163668365] 'process raft request'  (duration: 281.258371ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:27.280934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.24432ms","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-06T14:19:27.280969Z","caller":"traceutil/trace.go:171","msg":"trace[2031164339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5629; }","duration":"282.321854ms","start":"2026-05-06T14:19:26.998639Z","end":"2026-05-06T14:19:27.280961Z","steps":["trace[2031164339] 'agreement among raft nodes before linearized reading'  (duration: 282.2359ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:27.281067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.71723ms","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-06T14:19:27.281148Z","caller":"traceutil/trace.go:171","msg":"trace[939085454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5629; }","duration":"274.831176ms","start":"2026-05-06T14:19:27.0063Z","end":"2026-05-06T14:19:27.281131Z","steps":["trace[939085454] 'agreement among raft nodes before linearized reading'  (duration: 274.574734ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:27.28117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.320876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T14:19:27.2812Z","caller":"traceutil/trace.go:171","msg":"trace[1216304132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5629; }","duration":"262.361358ms","start":"2026-05-06T14:19:27.01883Z","end":"2026-05-06T14:19:27.281191Z","steps":["trace[1216304132] 'agreement among raft nodes before linearized reading'  (duration: 262.271684ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:19:27.281337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.401731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T14:19:27.281373Z","caller":"traceutil/trace.go:171","msg":"trace[483541746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5629; }","duration":"263.460994ms","start":"2026-05-06T14:19:27.017903Z","end":"2026-05-06T14:19:27.281364Z","steps":["trace[483541746] 'agreement among raft nodes before linearized reading'  (duration: 263.371049ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:19:45.406655Z","caller":"traceutil/trace.go:171","msg":"trace[1113523695] transaction","detail":"{read_only:false; response_revision:5747; number_of_response:1; }","duration":"102.331478ms","start":"2026-05-06T14:19:45.304287Z","end":"2026-05-06T14:19:45.406618Z","steps":["trace[1113523695] 'process raft request'  (duration: 102.026093ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:22:02.421926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.673188ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6530393172307105699 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6689 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T14:22:02.422Z","caller":"traceutil/trace.go:171","msg":"trace[1091690196] linearizableReadLoop","detail":"{readStateIndex:6946; appliedIndex:6945; }","duration":"105.82281ms","start":"2026-05-06T14:22:02.316168Z","end":"2026-05-06T14:22:02.42199Z","steps":["trace[1091690196] 'read index received'  (duration: 76.364µs)","trace[1091690196] 'applied index is now lower than readState.Index'  (duration: 105.745426ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T14:22:02.422121Z","caller":"traceutil/trace.go:171","msg":"trace[1788434059] transaction","detail":"{read_only:false; response_revision:6698; number_of_response:1; }","duration":"174.252579ms","start":"2026-05-06T14:22:02.247861Z","end":"2026-05-06T14:22:02.422114Z","steps":["trace[1788434059] 'process raft request'  (duration: 24.332428ms)","trace[1788434059] 'compare'  (duration: 149.549711ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T14:22:02.422268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.106316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-06T14:22:02.422286Z","caller":"traceutil/trace.go:171","msg":"trace[896092413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6698; }","duration":"106.191031ms","start":"2026-05-06T14:22:02.316091Z","end":"2026-05-06T14:22:02.422282Z","steps":["trace[896092413] 'agreement among raft nodes before linearized reading'  (duration: 106.120827ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:22:02.570577Z","caller":"traceutil/trace.go:171","msg":"trace[68208624] transaction","detail":"{read_only:false; response_revision:6700; number_of_response:1; }","duration":"144.054597ms","start":"2026-05-06T14:22:02.426498Z","end":"2026-05-06T14:22:02.570553Z","steps":["trace[68208624] 'process raft request'  (duration: 143.616733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T14:23:02.894825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.820812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-06T14:23:02.894949Z","caller":"traceutil/trace.go:171","msg":"trace[1696051375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7030; }","duration":"104.03128ms","start":"2026-05-06T14:23:02.79089Z","end":"2026-05-06T14:23:02.894921Z","steps":["trace[1696051375] 'range keys from in-memory index tree'  (duration: 103.541598ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:23:47.399384Z","caller":"traceutil/trace.go:171","msg":"trace[1305416984] transaction","detail":"{read_only:false; response_revision:7257; number_of_response:1; }","duration":"120.055619ms","start":"2026-05-06T14:23:47.279306Z","end":"2026-05-06T14:23:47.399362Z","steps":["trace[1305416984] 'process raft request'  (duration: 119.75743ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:24:03.259618Z","caller":"traceutil/trace.go:171","msg":"trace[1131383074] transaction","detail":"{read_only:false; response_revision:7334; number_of_response:1; }","duration":"135.206433ms","start":"2026-05-06T14:24:03.124389Z","end":"2026-05-06T14:24:03.259595Z","steps":["trace[1131383074] 'process raft request'  (duration: 135.066643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T14:24:09.659374Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5513}
{"level":"info","ts":"2026-05-06T14:24:09.750346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5513,"took":"89.64028ms","hash":2132964646,"current-db-size-bytes":53583872,"current-db-size":"54 MB","current-db-size-in-use-bytes":18264064,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-06T14:24:09.750538Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2132964646,"revision":5513,"compact-revision":2855}