{"level":"warn","ts":"2026-05-25T00:38:16.864353Z","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-25T00:38:16.864679Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-25T00:38:16.8648Z","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-25T00:38:16.86485Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]}
{"level":"info","ts":"2026-05-25T00:38:16.864913Z","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-25T00:38:16.866292Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]}
{"level":"info","ts":"2026-05-25T00:38:16.866422Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-25T00:38:16.871626Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.805692ms"}
{"level":"info","ts":"2026-05-25T00:38:16.883319Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"}
{"level":"info","ts":"2026-05-25T00:38:16.883423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-25T00:38:16.88345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"}
{"level":"info","ts":"2026-05-25T00:38:16.883463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-25T00:38:16.883478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"}
{"level":"info","ts":"2026-05-25T00:38:16.883528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"}
{"level":"warn","ts":"2026-05-25T00:38:16.891559Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-25T00:38:16.894064Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-25T00:38:16.89788Z","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-25T00:38:16.900114Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-25T00:38:16.900323Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-25T00:38:16.900558Z","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-25T00:38:16.900622Z","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-25T00:38:16.900633Z","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-25T00:38:16.903626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"}
{"level":"info","ts":"2026-05-25T00:38:16.904419Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]}
{"level":"info","ts":"2026-05-25T00:38:16.906828Z","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-25T00:38:16.906991Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"}
{"level":"info","ts":"2026-05-25T00:38:16.90702Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"}
{"level":"info","ts":"2026-05-25T00:38:16.907582Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-25T00:38:16.907636Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-25T00:38:17.884298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-25T00:38:17.884352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-25T00:38:17.884387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"}
{"level":"info","ts":"2026-05-25T00:38:17.8844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"}
{"level":"info","ts":"2026-05-25T00:38:17.884407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"}
{"level":"info","ts":"2026-05-25T00:38:17.884422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"}
{"level":"info","ts":"2026-05-25T00:38:17.884431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"}
{"level":"info","ts":"2026-05-25T00:38:17.893592Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-25T00:38:17.893668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-25T00:38:17.893636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-25T00:38:17.893874Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T00:38:17.894109Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-25T00:38:17.894153Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-25T00:38:17.896802Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-25T00:38:17.896886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"}
{"level":"info","ts":"2026-05-25T00:38:17.907198Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T00:38:17.907938Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T00:38:17.908056Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T00:38:54.223431Z","caller":"traceutil/trace.go:171","msg":"trace[159216616] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"156.930753ms","start":"2026-05-25T00:38:54.066476Z","end":"2026-05-25T00:38:54.223406Z","steps":["trace[159216616] 'process raft request'  (duration: 156.784989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.230249Z","caller":"traceutil/trace.go:171","msg":"trace[1420242849] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"123.585088ms","start":"2026-05-25T00:38:54.106611Z","end":"2026-05-25T00:38:54.230196Z","steps":["trace[1420242849] 'process raft request'  (duration: 123.191228ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.230302Z","caller":"traceutil/trace.go:171","msg":"trace[641912687] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"115.925177ms","start":"2026-05-25T00:38:54.11436Z","end":"2026-05-25T00:38:54.230285Z","steps":["trace[641912687] 'process raft request'  (duration: 115.658248ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.230646Z","caller":"traceutil/trace.go:171","msg":"trace[1682353288] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"115.036161ms","start":"2026-05-25T00:38:54.115597Z","end":"2026-05-25T00:38:54.230633Z","steps":["trace[1682353288] 'process raft request'  (duration: 114.507456ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.230883Z","caller":"traceutil/trace.go:171","msg":"trace[178580655] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"108.613554ms","start":"2026-05-25T00:38:54.122261Z","end":"2026-05-25T00:38:54.230874Z","steps":["trace[178580655] 'process raft request'  (duration: 108.45587ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.231006Z","caller":"traceutil/trace.go:171","msg":"trace[434751177] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"105.674162ms","start":"2026-05-25T00:38:54.125325Z","end":"2026-05-25T00:38:54.230999Z","steps":["trace[434751177] 'process raft request'  (duration: 105.560739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.23108Z","caller":"traceutil/trace.go:171","msg":"trace[29880159] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"105.652511ms","start":"2026-05-25T00:38:54.125412Z","end":"2026-05-25T00:38:54.231065Z","steps":["trace[29880159] 'process raft request'  (duration: 105.541818ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.231077Z","caller":"traceutil/trace.go:171","msg":"trace[1878560113] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"107.456992ms","start":"2026-05-25T00:38:54.123555Z","end":"2026-05-25T00:38:54.231012Z","steps":["trace[1878560113] 'process raft request'  (duration: 107.253716ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.231205Z","caller":"traceutil/trace.go:171","msg":"trace[498516681] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"105.488997ms","start":"2026-05-25T00:38:54.125686Z","end":"2026-05-25T00:38:54.231175Z","steps":["trace[498516681] 'process raft request'  (duration: 105.328403ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.727404Z","caller":"traceutil/trace.go:171","msg":"trace[1994830036] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"162.373305ms","start":"2026-05-25T00:38:54.565009Z","end":"2026-05-25T00:38:54.727382Z","steps":["trace[1994830036] 'process raft request'  (duration: 162.278062ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:38:54.729545Z","caller":"traceutil/trace.go:171","msg":"trace[521049896] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"223.618803ms","start":"2026-05-25T00:38:54.505869Z","end":"2026-05-25T00:38:54.729487Z","steps":["trace[521049896] 'process raft request'  (duration: 216.396013ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:00.369956Z","caller":"traceutil/trace.go:171","msg":"trace[929855199] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"110.144089ms","start":"2026-05-25T00:39:00.259776Z","end":"2026-05-25T00:39:00.36992Z","steps":["trace[929855199] 'process raft request'  (duration: 109.382788ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:00.559495Z","caller":"traceutil/trace.go:171","msg":"trace[1592642955] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"198.780161ms","start":"2026-05-25T00:39:00.360675Z","end":"2026-05-25T00:39:00.559455Z","steps":["trace[1592642955] 'process raft request'  (duration: 197.612078ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:00.568185Z","caller":"traceutil/trace.go:171","msg":"trace[1852353577] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"192.958889ms","start":"2026-05-25T00:39:00.375201Z","end":"2026-05-25T00:39:00.56816Z","steps":["trace[1852353577] 'process raft request'  (duration: 192.831935ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:01.146128Z","caller":"traceutil/trace.go:171","msg":"trace[531591001] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"518.002657ms","start":"2026-05-25T00:39:00.628096Z","end":"2026-05-25T00:39:01.146099Z","steps":["trace[531591001] 'process raft request'  (duration: 495.537273ms)","trace[531591001] 'compare'  (duration: 20.827389ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:39:01.14627Z","caller":"traceutil/trace.go:171","msg":"trace[815566452] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"516.902256ms","start":"2026-05-25T00:39:00.629356Z","end":"2026-05-25T00:39:01.146258Z","steps":["trace[815566452] 'read index received'  (duration: 494.297448ms)","trace[815566452] 'applied index is now lower than readState.Index'  (duration: 22.603038ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:39:01.146562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.180174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cpjdd\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-25T00:39:01.14666Z","caller":"traceutil/trace.go:171","msg":"trace[236359291] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cpjdd; range_end:; response_count:1; response_revision:589; }","duration":"517.334518ms","start":"2026-05-25T00:39:00.629308Z","end":"2026-05-25T00:39:01.146642Z","steps":["trace[236359291] 'agreement among raft nodes before linearized reading'  (duration: 517.04076ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:01.146709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:00.629282Z","time spent":"517.41879ms","remote":"127.0.0.1:38444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-cpjdd\" "}
{"level":"warn","ts":"2026-05-25T00:39:01.14741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:00.628063Z","time spent":"518.299325ms","remote":"127.0.0.1:38744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-05-25T00:39:01.167512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.976982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-25T00:39:01.167575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.760416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-25T00:39:01.167634Z","caller":"traceutil/trace.go:171","msg":"trace[934885370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"165.131297ms","start":"2026-05-25T00:39:01.002477Z","end":"2026-05-25T00:39:01.167608Z","steps":["trace[934885370] 'agreement among raft nodes before linearized reading'  (duration: 164.893131ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:01.167676Z","caller":"traceutil/trace.go:171","msg":"trace[1921099014] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:590; }","duration":"308.879139ms","start":"2026-05-25T00:39:00.858747Z","end":"2026-05-25T00:39:01.167626Z","steps":["trace[1921099014] 'agreement among raft nodes before linearized reading'  (duration: 308.768536ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:01.167697Z","caller":"traceutil/trace.go:171","msg":"trace[2057662395] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"518.556462ms","start":"2026-05-25T00:39:00.649103Z","end":"2026-05-25T00:39:01.16766Z","steps":["trace[2057662395] 'process raft request'  (duration: 518.097519ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:01.167744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:00.858719Z","time spent":"309.016942ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.23\" "}
{"level":"warn","ts":"2026-05-25T00:39:01.168141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:00.649082Z","time spent":"518.690696ms","remote":"127.0.0.1:38508","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:439 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-25T00:39:16.827393Z","caller":"traceutil/trace.go:171","msg":"trace[1163442692] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"134.265727ms","start":"2026-05-25T00:39:16.693108Z","end":"2026-05-25T00:39:16.827373Z","steps":["trace[1163442692] 'read index received'  (duration: 134.105942ms)","trace[1163442692] 'applied index is now lower than readState.Index'  (duration: 158.815µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:39:16.827498Z","caller":"traceutil/trace.go:171","msg":"trace[1235944144] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"158.548603ms","start":"2026-05-25T00:39:16.66894Z","end":"2026-05-25T00:39:16.827489Z","steps":["trace[1235944144] 'process raft request'  (duration: 158.313406ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:16.82783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.712249ms","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-25T00:39:16.827883Z","caller":"traceutil/trace.go:171","msg":"trace[977707396] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:753; }","duration":"134.77564ms","start":"2026-05-25T00:39:16.693095Z","end":"2026-05-25T00:39:16.827871Z","steps":["trace[977707396] 'agreement among raft nodes before linearized reading'  (duration: 134.657747ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:17.038364Z","caller":"traceutil/trace.go:171","msg":"trace[999857619] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"206.61555ms","start":"2026-05-25T00:39:16.831688Z","end":"2026-05-25T00:39:17.038303Z","steps":["trace[999857619] 'process raft request'  (duration: 199.248256ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:17.039495Z","caller":"traceutil/trace.go:171","msg":"trace[1446987392] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"203.892324ms","start":"2026-05-25T00:39:16.835574Z","end":"2026-05-25T00:39:17.039466Z","steps":["trace[1446987392] 'process raft request'  (duration: 203.512453ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:28.773083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954932603632244,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-25T00:39:28.797204Z","caller":"traceutil/trace.go:171","msg":"trace[1707190760] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"563.35749ms","start":"2026-05-25T00:39:28.233818Z","end":"2026-05-25T00:39:28.797175Z","steps":["trace[1707190760] 'process raft request'  (duration: 563.218137ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:28.79722Z","caller":"traceutil/trace.go:171","msg":"trace[1906585926] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"563.761422ms","start":"2026-05-25T00:39:28.233401Z","end":"2026-05-25T00:39:28.797163Z","steps":["trace[1906585926] 'process raft request'  (duration: 562.610949ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:28.797373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:28.233801Z","time spent":"563.482193ms","remote":"127.0.0.1:38670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3681,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/local-path-storage/local-path-provisioner\" mod_revision:890 > success:<request_put:<key:\"/registry/deployments/local-path-storage/local-path-provisioner\" value_size:3610 >> failure:<request_range:<key:\"/registry/deployments/local-path-storage/local-path-provisioner\" > >"}
{"level":"warn","ts":"2026-05-25T00:39:28.79744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:28.233379Z","time spent":"563.944878ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3249,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" mod_revision:893 > success:<request_put:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" value_size:3168 >> failure:<request_range:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" > >"}
{"level":"info","ts":"2026-05-25T00:39:28.800839Z","caller":"traceutil/trace.go:171","msg":"trace[1866054930] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:922; }","duration":"528.323501ms","start":"2026-05-25T00:39:28.272491Z","end":"2026-05-25T00:39:28.800815Z","steps":["trace[1866054930] 'read index received'  (duration: 523.507996ms)","trace[1866054930] 'applied index is now lower than readState.Index'  (duration: 4.814555ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:39:28.800874Z","caller":"traceutil/trace.go:171","msg":"trace[707829756] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"561.662492ms","start":"2026-05-25T00:39:28.23919Z","end":"2026-05-25T00:39:28.800853Z","steps":["trace[707829756] 'process raft request'  (duration: 561.508848ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:28.801095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.84296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-25T00:39:28.801095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.392823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"}
{"level":"warn","ts":"2026-05-25T00:39:28.801117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:28.239179Z","time spent":"561.833717ms","remote":"127.0.0.1:38444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3595,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-zph86\" mod_revision:891 > success:<request_put:<key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-zph86\" value_size:3515 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-zph86\" > >"}
{"level":"info","ts":"2026-05-25T00:39:28.801141Z","caller":"traceutil/trace.go:171","msg":"trace[1717606870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:897; }","duration":"168.945673ms","start":"2026-05-25T00:39:28.632184Z","end":"2026-05-25T00:39:28.801129Z","steps":["trace[1717606870] 'agreement among raft nodes before linearized reading'  (duration: 168.804679ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:28.801148Z","caller":"traceutil/trace.go:171","msg":"trace[1678970942] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:897; }","duration":"332.484016ms","start":"2026-05-25T00:39:28.46865Z","end":"2026-05-25T00:39:28.801134Z","steps":["trace[1678970942] 'agreement among raft nodes before linearized reading'  (duration: 332.312991ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:28.801194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:28.468633Z","time spent":"332.552268ms","remote":"127.0.0.1:38462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "}
{"level":"warn","ts":"2026-05-25T00:39:28.802177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.36844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"}
{"level":"info","ts":"2026-05-25T00:39:28.802559Z","caller":"traceutil/trace.go:171","msg":"trace[1694618968] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:897; }","duration":"529.933536ms","start":"2026-05-25T00:39:28.272452Z","end":"2026-05-25T00:39:28.802385Z","steps":["trace[1694618968] 'agreement among raft nodes before linearized reading'  (duration: 528.507226ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:28.802729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:39:28.272439Z","time spent":"530.221915ms","remote":"127.0.0.1:38372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12778,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "}
{"level":"info","ts":"2026-05-25T00:39:33.12245Z","caller":"traceutil/trace.go:171","msg":"trace[2075336704] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:961; }","duration":"120.061446ms","start":"2026-05-25T00:39:33.002366Z","end":"2026-05-25T00:39:33.122427Z","steps":["trace[2075336704] 'read index received'  (duration: 119.83809ms)","trace[2075336704] 'applied index is now lower than readState.Index'  (duration: 222.416µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:39:33.122632Z","caller":"traceutil/trace.go:171","msg":"trace[1296930960] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"153.383468ms","start":"2026-05-25T00:39:32.969184Z","end":"2026-05-25T00:39:33.122568Z","steps":["trace[1296930960] 'process raft request'  (duration: 153.105791ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:33.122701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.298103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:39:33.122742Z","caller":"traceutil/trace.go:171","msg":"trace[1029985316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:933; }","duration":"120.411666ms","start":"2026-05-25T00:39:33.002321Z","end":"2026-05-25T00:39:33.122732Z","steps":["trace[1029985316] 'agreement among raft nodes before linearized reading'  (duration: 120.310033ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:35.815556Z","caller":"traceutil/trace.go:171","msg":"trace[842226482] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"179.770095ms","start":"2026-05-25T00:39:35.635769Z","end":"2026-05-25T00:39:35.815539Z","steps":["trace[842226482] 'process raft request'  (duration: 179.659692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:35.819867Z","caller":"traceutil/trace.go:171","msg":"trace[1615079337] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"184.046125ms","start":"2026-05-25T00:39:35.635809Z","end":"2026-05-25T00:39:35.819855Z","steps":["trace[1615079337] 'process raft request'  (duration: 183.809258ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:39:35.820021Z","caller":"traceutil/trace.go:171","msg":"trace[460184231] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:971; }","duration":"125.259882ms","start":"2026-05-25T00:39:35.694738Z","end":"2026-05-25T00:39:35.819998Z","steps":["trace[460184231] 'read index received'  (duration: 120.767966ms)","trace[460184231] 'applied index is now lower than readState.Index'  (duration: 4.491096ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:39:35.820064Z","caller":"traceutil/trace.go:171","msg":"trace[431311783] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"105.330905ms","start":"2026-05-25T00:39:35.714709Z","end":"2026-05-25T00:39:35.82004Z","steps":["trace[431311783] 'process raft request'  (duration: 105.160301ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:39:35.82025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.500489ms","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-25T00:39:35.820283Z","caller":"traceutil/trace.go:171","msg":"trace[530198753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:945; }","duration":"125.584541ms","start":"2026-05-25T00:39:35.694691Z","end":"2026-05-25T00:39:35.820275Z","steps":["trace[530198753] 'agreement among raft nodes before linearized reading'  (duration: 125.443487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.137869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.178505ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125954932603634102 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1756 > 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-25T00:40:36.138188Z","caller":"traceutil/trace.go:171","msg":"trace[2059371968] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"375.247521ms","start":"2026-05-25T00:40:35.762899Z","end":"2026-05-25T00:40:36.138147Z","steps":["trace[2059371968] 'process raft request'  (duration: 132.432409ms)","trace[2059371968] 'compare'  (duration: 242.00718ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:40:36.138312Z","caller":"traceutil/trace.go:171","msg":"trace[1387278549] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"375.309093ms","start":"2026-05-25T00:40:35.762969Z","end":"2026-05-25T00:40:36.138278Z","steps":["trace[1387278549] 'process raft request'  (duration: 375.052736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.138374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:40:35.762882Z","time spent":"375.387735ms","remote":"127.0.0.1:38508","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:1756 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-25T00:40:36.138428Z","caller":"traceutil/trace.go:171","msg":"trace[1408242479] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"101.863174ms","start":"2026-05-25T00:40:36.036539Z","end":"2026-05-25T00:40:36.138402Z","steps":["trace[1408242479] 'process raft request'  (duration: 101.70699ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.13849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:40:35.762964Z","time spent":"375.433156ms","remote":"127.0.0.1:38508","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:1754 > 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-25T00:40:36.138426Z","caller":"traceutil/trace.go:171","msg":"trace[637787904] linearizableReadLoop","detail":"{readStateIndex:1890; appliedIndex:1888; }","duration":"196.013115ms","start":"2026-05-25T00:40:35.942387Z","end":"2026-05-25T00:40:36.1384Z","steps":["trace[637787904] 'read index received'  (duration: 34.571µs)","trace[637787904] 'applied index is now lower than readState.Index'  (duration: 195.975754ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:40:36.138751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.346484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8fe7255c-e72f-4da8-805f-b4e803c79a9f\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-05-25T00:40:36.138836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.679472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:40:36.13881Z","caller":"traceutil/trace.go:171","msg":"trace[692759530] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8fe7255c-e72f-4da8-805f-b4e803c79a9f; range_end:; response_count:1; response_revision:1821; }","duration":"196.450647ms","start":"2026-05-25T00:40:35.94234Z","end":"2026-05-25T00:40:36.138791Z","steps":["trace[692759530] 'agreement among raft nodes before linearized reading'  (duration: 196.18774ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:40:36.138941Z","caller":"traceutil/trace.go:171","msg":"trace[1811441423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1821; }","duration":"134.849307ms","start":"2026-05-25T00:40:36.004072Z","end":"2026-05-25T00:40:36.138922Z","steps":["trace[1811441423] 'agreement among raft nodes before linearized reading'  (duration: 134.668632ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.463735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.537825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-05-25T00:40:36.463821Z","caller":"traceutil/trace.go:171","msg":"trace[1281996970] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1823; }","duration":"198.69649ms","start":"2026-05-25T00:40:36.265102Z","end":"2026-05-25T00:40:36.463798Z","steps":["trace[1281996970] 'range keys from in-memory index tree'  (duration: 198.310099ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.664582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.109033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125954932603634111 > lease_revoke:<id:0c869e5c91743f89>","response":"size:28"}
{"level":"info","ts":"2026-05-25T00:40:36.664877Z","caller":"traceutil/trace.go:171","msg":"trace[1008683954] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1893; }","duration":"203.896075ms","start":"2026-05-25T00:40:36.460956Z","end":"2026-05-25T00:40:36.664852Z","steps":["trace[1008683954] 'read index received'  (duration: 12.808508ms)","trace[1008683954] 'applied index is now lower than readState.Index'  (duration: 191.086057ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:40:36.664907Z","caller":"traceutil/trace.go:171","msg":"trace[1659221057] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"306.199972ms","start":"2026-05-25T00:40:36.358666Z","end":"2026-05-25T00:40:36.664866Z","steps":["trace[1659221057] 'process raft request'  (duration: 306.013877ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.665127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:40:36.358641Z","time spent":"306.357997ms","remote":"127.0.0.1:38508","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:1804 > 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-25T00:40:36.665246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.279236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-25T00:40:36.665335Z","caller":"traceutil/trace.go:171","msg":"trace[1685709185] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1824; }","duration":"204.41608ms","start":"2026-05-25T00:40:36.460896Z","end":"2026-05-25T00:40:36.665312Z","steps":["trace[1685709185] 'agreement among raft nodes before linearized reading'  (duration: 204.132162ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:40:36.721026Z","caller":"traceutil/trace.go:171","msg":"trace[1703154091] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"252.581095ms","start":"2026-05-25T00:40:36.468423Z","end":"2026-05-25T00:40:36.721004Z","steps":["trace[1703154091] 'process raft request'  (duration: 252.288727ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.721077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.433711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-25T00:40:36.721158Z","caller":"traceutil/trace.go:171","msg":"trace[1473666269] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1825; }","duration":"126.580805ms","start":"2026-05-25T00:40:36.594559Z","end":"2026-05-25T00:40:36.721139Z","steps":["trace[1473666269] 'agreement among raft nodes before linearized reading'  (duration: 126.40935ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:40:36.721188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.619012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8fe7255c-e72f-4da8-805f-b4e803c79a9f\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-25T00:40:36.72126Z","caller":"traceutil/trace.go:171","msg":"trace[337978676] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8fe7255c-e72f-4da8-805f-b4e803c79a9f; range_end:; response_count:1; response_revision:1825; }","duration":"109.714975ms","start":"2026-05-25T00:40:36.611519Z","end":"2026-05-25T00:40:36.721234Z","steps":["trace[337978676] 'agreement among raft nodes before linearized reading'  (duration: 109.506679ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:06.436262Z","caller":"traceutil/trace.go:171","msg":"trace[1213387627] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"137.45585ms","start":"2026-05-25T00:41:06.298783Z","end":"2026-05-25T00:41:06.436239Z","steps":["trace[1213387627] 'process raft request'  (duration: 135.410942ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:06.43637Z","caller":"traceutil/trace.go:171","msg":"trace[1351207341] linearizableReadLoop","detail":"{readStateIndex:2121; appliedIndex:2119; }","duration":"135.802863ms","start":"2026-05-25T00:41:06.300545Z","end":"2026-05-25T00:41:06.436348Z","steps":["trace[1351207341] 'read index received'  (duration: 133.585931ms)","trace[1351207341] 'applied index is now lower than readState.Index'  (duration: 2.216052ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:41:06.436805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.250976ms","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-25T00:41:06.436859Z","caller":"traceutil/trace.go:171","msg":"trace[1988996256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2043; }","duration":"136.340727ms","start":"2026-05-25T00:41:06.300504Z","end":"2026-05-25T00:41:06.436845Z","steps":["trace[1988996256] 'agreement among raft nodes before linearized reading'  (duration: 136.189223ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:06.436997Z","caller":"traceutil/trace.go:171","msg":"trace[446645417] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"136.993915ms","start":"2026-05-25T00:41:06.299993Z","end":"2026-05-25T00:41:06.436987Z","steps":["trace[446645417] 'process raft request'  (duration: 136.200323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:41:06.437141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.37452ms","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-25T00:41:06.437174Z","caller":"traceutil/trace.go:171","msg":"trace[251502705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2043; }","duration":"111.441662ms","start":"2026-05-25T00:41:06.325724Z","end":"2026-05-25T00:41:06.437166Z","steps":["trace[251502705] 'agreement among raft nodes before linearized reading'  (duration: 111.35913ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:12.443538Z","caller":"traceutil/trace.go:171","msg":"trace[899400251] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"130.66789ms","start":"2026-05-25T00:41:12.312845Z","end":"2026-05-25T00:41:12.443513Z","steps":["trace[899400251] 'process raft request'  (duration: 130.522846ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:41:12.608927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.617856ms","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-25T00:41:12.609013Z","caller":"traceutil/trace.go:171","msg":"trace[1863498068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2074; }","duration":"145.740389ms","start":"2026-05-25T00:41:12.463253Z","end":"2026-05-25T00:41:12.608993Z","steps":["trace[1863498068] 'range keys from in-memory index tree'  (duration: 145.449981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:12.609656Z","caller":"traceutil/trace.go:171","msg":"trace[1875732445] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"144.483424ms","start":"2026-05-25T00:41:12.465151Z","end":"2026-05-25T00:41:12.609634Z","steps":["trace[1875732445] 'process raft request'  (duration: 144.431512ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:12.609966Z","caller":"traceutil/trace.go:171","msg":"trace[1631313788] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"144.803832ms","start":"2026-05-25T00:41:12.46514Z","end":"2026-05-25T00:41:12.609944Z","steps":["trace[1631313788] 'process raft request'  (duration: 144.37132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:12.610052Z","caller":"traceutil/trace.go:171","msg":"trace[1988478582] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"145.302527ms","start":"2026-05-25T00:41:12.464704Z","end":"2026-05-25T00:41:12.610006Z","steps":["trace[1988478582] 'process raft request'  (duration: 128.262461ms)","trace[1988478582] 'compare'  (duration: 16.255724ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:41:12.890015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.601397ms","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-25T00:41:12.890141Z","caller":"traceutil/trace.go:171","msg":"trace[1441949729] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2077; }","duration":"149.755922ms","start":"2026-05-25T00:41:12.740367Z","end":"2026-05-25T00:41:12.890123Z","steps":["trace[1441949729] 'range keys from in-memory index tree'  (duration: 149.568967ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:41:12.890613Z","caller":"traceutil/trace.go:171","msg":"trace[1842074316] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"277.593543ms","start":"2026-05-25T00:41:12.612989Z","end":"2026-05-25T00:41:12.890583Z","steps":["trace[1842074316] 'process raft request'  (duration: 187.384853ms)","trace[1842074316] 'compare'  (duration: 89.639084ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:42:15.094409Z","caller":"traceutil/trace.go:171","msg":"trace[394835043] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"108.338516ms","start":"2026-05-25T00:42:14.986049Z","end":"2026-05-25T00:42:15.094387Z","steps":["trace[394835043] 'process raft request'  (duration: 108.292554ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:42:15.094454Z","caller":"traceutil/trace.go:171","msg":"trace[2128163894] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"109.113317ms","start":"2026-05-25T00:42:14.985307Z","end":"2026-05-25T00:42:15.094421Z","steps":["trace[2128163894] 'process raft request'  (duration: 106.899655ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:42:15.094572Z","caller":"traceutil/trace.go:171","msg":"trace[797777526] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"108.682104ms","start":"2026-05-25T00:42:14.98588Z","end":"2026-05-25T00:42:15.094562Z","steps":["trace[797777526] 'process raft request'  (duration: 108.400217ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:42:48.103136Z","caller":"traceutil/trace.go:171","msg":"trace[1714097609] linearizableReadLoop","detail":"{readStateIndex:2799; appliedIndex:2798; }","duration":"147.102506ms","start":"2026-05-25T00:42:47.956009Z","end":"2026-05-25T00:42:48.103112Z","steps":["trace[1714097609] 'read index received'  (duration: 146.920191ms)","trace[1714097609] 'applied index is now lower than readState.Index'  (duration: 181.285µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:42:48.10334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.597169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:42:48.103381Z","caller":"traceutil/trace.go:171","msg":"trace[1330027334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2698; }","duration":"100.65125ms","start":"2026-05-25T00:42:48.002718Z","end":"2026-05-25T00:42:48.103369Z","steps":["trace[1330027334] 'agreement among raft nodes before linearized reading'  (duration: 100.573248ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:42:48.103216Z","caller":"traceutil/trace.go:171","msg":"trace[1145932236] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"228.17415ms","start":"2026-05-25T00:42:47.875002Z","end":"2026-05-25T00:42:48.103176Z","steps":["trace[1145932236] 'process raft request'  (duration: 227.957984ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:42:48.103754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.719814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-25T00:42:48.103992Z","caller":"traceutil/trace.go:171","msg":"trace[1111014043] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2698; }","duration":"147.853917ms","start":"2026-05-25T00:42:47.955967Z","end":"2026-05-25T00:42:48.103821Z","steps":["trace[1111014043] 'agreement among raft nodes before linearized reading'  (duration: 147.283271ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:45:47.048692Z","caller":"traceutil/trace.go:171","msg":"trace[276159353] transaction","detail":"{read_only:false; response_revision:3796; number_of_response:1; }","duration":"317.690591ms","start":"2026-05-25T00:45:46.730971Z","end":"2026-05-25T00:45:47.048662Z","steps":["trace[276159353] 'process raft request'  (duration: 317.494297ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:45:47.048999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:45:46.73094Z","time spent":"317.845024ms","remote":"127.0.0.1:38352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/kube-prometheus-stack.18b2a863300cd41c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/kube-prometheus-stack.18b2a863300cd41c\" value_size:625 lease:902582895748863223 >> failure:<>"}
{"level":"info","ts":"2026-05-25T00:45:47.0529Z","caller":"traceutil/trace.go:171","msg":"trace[585956144] transaction","detail":"{read_only:false; response_revision:3797; number_of_response:1; }","duration":"319.271704ms","start":"2026-05-25T00:45:46.733599Z","end":"2026-05-25T00:45:47.05287Z","steps":["trace[585956144] 'process raft request'  (duration: 319.07406ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:45:47.053064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:45:46.733574Z","time spent":"319.400986ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1113,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cert-manager.io/clusterissuers/kube-prometheus-stack\" mod_revision:3714 > success:<request_put:<key:\"/registry/cert-manager.io/clusterissuers/kube-prometheus-stack\" value_size:1043 >> failure:<request_range:<key:\"/registry/cert-manager.io/clusterissuers/kube-prometheus-stack\" > >"}
{"level":"info","ts":"2026-05-25T00:45:47.053193Z","caller":"traceutil/trace.go:171","msg":"trace[1001271972] linearizableReadLoop","detail":"{readStateIndex:3943; appliedIndex:3940; }","duration":"145.289564ms","start":"2026-05-25T00:45:46.907883Z","end":"2026-05-25T00:45:47.053172Z","steps":["trace[1001271972] 'read index received'  (duration: 140.69561ms)","trace[1001271972] 'applied index is now lower than readState.Index'  (duration: 4.592354ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:45:47.053396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.495028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:45:47.053495Z","caller":"traceutil/trace.go:171","msg":"trace[2061561920] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:3798; }","duration":"145.638451ms","start":"2026-05-25T00:45:46.907842Z","end":"2026-05-25T00:45:47.053481Z","steps":["trace[2061561920] 'agreement among raft nodes before linearized reading'  (duration: 145.475108ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:45:47.053827Z","caller":"traceutil/trace.go:171","msg":"trace[714759489] transaction","detail":"{read_only:false; response_revision:3798; number_of_response:1; }","duration":"319.58001ms","start":"2026-05-25T00:45:46.734232Z","end":"2026-05-25T00:45:47.053812Z","steps":["trace[714759489] 'process raft request'  (duration: 318.5697ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:45:47.053921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:45:46.734204Z","time spent":"319.663311ms","remote":"127.0.0.1:38508","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:3765 > 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-25T00:45:58.421157Z","caller":"traceutil/trace.go:171","msg":"trace[1894268573] transaction","detail":"{read_only:false; response_revision:3861; number_of_response:1; }","duration":"203.165318ms","start":"2026-05-25T00:45:58.217956Z","end":"2026-05-25T00:45:58.421121Z","steps":["trace[1894268573] 'process raft request'  (duration: 201.920611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:45:58.423142Z","caller":"traceutil/trace.go:171","msg":"trace[887490905] linearizableReadLoop","detail":"{readStateIndex:4009; appliedIndex:4007; }","duration":"133.925056ms","start":"2026-05-25T00:45:58.289188Z","end":"2026-05-25T00:45:58.423113Z","steps":["trace[887490905] 'read index received'  (duration: 130.699008ms)","trace[887490905] 'applied index is now lower than readState.Index'  (duration: 3.224748ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:45:58.423329Z","caller":"traceutil/trace.go:171","msg":"trace[1071085463] transaction","detail":"{read_only:false; response_revision:3862; number_of_response:1; }","duration":"196.463058ms","start":"2026-05-25T00:45:58.226832Z","end":"2026-05-25T00:45:58.423295Z","steps":["trace[1071085463] 'process raft request'  (duration: 196.11196ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:45:58.423446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.238983ms","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-25T00:45:58.423506Z","caller":"traceutil/trace.go:171","msg":"trace[869861796] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3862; }","duration":"134.359276ms","start":"2026-05-25T00:45:58.289137Z","end":"2026-05-25T00:45:58.423496Z","steps":["trace[869861796] 'agreement among raft nodes before linearized reading'  (duration: 134.128291ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:04.72435Z","caller":"traceutil/trace.go:171","msg":"trace[673614191] linearizableReadLoop","detail":"{readStateIndex:4046; appliedIndex:4045; }","duration":"274.549267ms","start":"2026-05-25T00:46:04.449774Z","end":"2026-05-25T00:46:04.724323Z","steps":["trace[673614191] 'read index received'  (duration: 274.355313ms)","trace[673614191] 'applied index is now lower than readState.Index'  (duration: 192.314µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:46:04.724769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.957146ms","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-25T00:46:04.724893Z","caller":"traceutil/trace.go:171","msg":"trace[215523735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3898; }","duration":"275.13021ms","start":"2026-05-25T00:46:04.449735Z","end":"2026-05-25T00:46:04.724865Z","steps":["trace[215523735] 'agreement among raft nodes before linearized reading'  (duration: 274.812313ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:04.724931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.446105ms","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-25T00:46:04.725012Z","caller":"traceutil/trace.go:171","msg":"trace[714512101] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3898; }","duration":"273.564527ms","start":"2026-05-25T00:46:04.451428Z","end":"2026-05-25T00:46:04.724993Z","steps":["trace[714512101] 'agreement among raft nodes before linearized reading'  (duration: 273.301122ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:04.72516Z","caller":"traceutil/trace.go:171","msg":"trace[1947170363] transaction","detail":"{read_only:false; response_revision:3898; number_of_response:1; }","duration":"277.799187ms","start":"2026-05-25T00:46:04.447341Z","end":"2026-05-25T00:46:04.725141Z","steps":["trace[1947170363] 'process raft request'  (duration: 276.798516ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:04.725387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.2758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-25T00:46:04.725453Z","caller":"traceutil/trace.go:171","msg":"trace[791309838] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3898; }","duration":"264.383072ms","start":"2026-05-25T00:46:04.461055Z","end":"2026-05-25T00:46:04.725438Z","steps":["trace[791309838] 'agreement among raft nodes before linearized reading'  (duration: 264.231739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:04.725602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.73869ms","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-25T00:46:04.725647Z","caller":"traceutil/trace.go:171","msg":"trace[125930744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3898; }","duration":"273.793081ms","start":"2026-05-25T00:46:04.451842Z","end":"2026-05-25T00:46:04.725635Z","steps":["trace[125930744] 'agreement among raft nodes before linearized reading'  (duration: 273.683819ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:33.75934Z","caller":"traceutil/trace.go:171","msg":"trace[1674057269] linearizableReadLoop","detail":"{readStateIndex:4643; appliedIndex:4642; }","duration":"121.168796ms","start":"2026-05-25T00:46:33.638152Z","end":"2026-05-25T00:46:33.75932Z","steps":["trace[1674057269] 'read index received'  (duration: 120.362398ms)","trace[1674057269] 'applied index is now lower than readState.Index'  (duration: 805.528µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:46:33.759425Z","caller":"traceutil/trace.go:171","msg":"trace[948414459] transaction","detail":"{read_only:false; response_revision:4469; number_of_response:1; }","duration":"161.695534ms","start":"2026-05-25T00:46:33.597694Z","end":"2026-05-25T00:46:33.759389Z","steps":["trace[948414459] 'process raft request'  (duration: 160.879016ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:33.759722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.532986ms","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-25T00:46:33.759809Z","caller":"traceutil/trace.go:171","msg":"trace[1748184301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4469; }","duration":"121.680488ms","start":"2026-05-25T00:46:33.638109Z","end":"2026-05-25T00:46:33.759789Z","steps":["trace[1748184301] 'agreement among raft nodes before linearized reading'  (duration: 121.329669ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:33.787003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.493044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:9424"}
{"level":"info","ts":"2026-05-25T00:46:33.787095Z","caller":"traceutil/trace.go:171","msg":"trace[994610774] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:4472; }","duration":"135.618387ms","start":"2026-05-25T00:46:33.651456Z","end":"2026-05-25T00:46:33.787075Z","steps":["trace[994610774] 'agreement among raft nodes before linearized reading'  (duration: 135.369931ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:33.787045Z","caller":"traceutil/trace.go:171","msg":"trace[1608682717] transaction","detail":"{read_only:false; response_revision:4470; number_of_response:1; }","duration":"100.368886ms","start":"2026-05-25T00:46:33.686643Z","end":"2026-05-25T00:46:33.787012Z","steps":["trace[1608682717] 'process raft request'  (duration: 99.533848ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:43.217643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.69057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-05-25T00:46:43.217805Z","caller":"traceutil/trace.go:171","msg":"trace[151094565] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4703; }","duration":"291.895305ms","start":"2026-05-25T00:46:42.925886Z","end":"2026-05-25T00:46:43.217781Z","steps":["trace[151094565] 'range keys from in-memory index tree'  (duration: 291.512526ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:43.218156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.230887ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125954932603641114 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4624 > 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-25T00:46:43.218246Z","caller":"traceutil/trace.go:171","msg":"trace[1745364717] linearizableReadLoop","detail":"{readStateIndex:4882; appliedIndex:4881; }","duration":"215.685595ms","start":"2026-05-25T00:46:43.002544Z","end":"2026-05-25T00:46:43.21823Z","steps":["trace[1745364717] 'read index received'  (duration: 7.236332ms)","trace[1745364717] 'applied index is now lower than readState.Index'  (duration: 208.447873ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:46:43.218379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.834338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:46:43.218414Z","caller":"traceutil/trace.go:171","msg":"trace[703039836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4704; }","duration":"215.928261ms","start":"2026-05-25T00:46:43.002476Z","end":"2026-05-25T00:46:43.218405Z","steps":["trace[703039836] 'agreement among raft nodes before linearized reading'  (duration: 215.835739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:43.218444Z","caller":"traceutil/trace.go:171","msg":"trace[932583189] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"290.584096ms","start":"2026-05-25T00:46:42.927726Z","end":"2026-05-25T00:46:43.21831Z","steps":["trace[932583189] 'process raft request'  (duration: 82.111203ms)","trace[932583189] 'compare'  (duration: 207.938631ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:46:43.218602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.662208ms","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-25T00:46:43.218666Z","caller":"traceutil/trace.go:171","msg":"trace[307228951] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4704; }","duration":"204.76479ms","start":"2026-05-25T00:46:43.013884Z","end":"2026-05-25T00:46:43.218649Z","steps":["trace[307228951] 'agreement among raft nodes before linearized reading'  (duration: 204.541105ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:43.218837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.760808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"warn","ts":"2026-05-25T00:46:43.218855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.89111ms","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-25T00:46:43.218894Z","caller":"traceutil/trace.go:171","msg":"trace[723262568] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4704; }","duration":"171.965532ms","start":"2026-05-25T00:46:43.046919Z","end":"2026-05-25T00:46:43.218884Z","steps":["trace[723262568] 'agreement among raft nodes before linearized reading'  (duration: 171.84786ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:43.218913Z","caller":"traceutil/trace.go:171","msg":"trace[1986228270] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4704; }","duration":"171.86419ms","start":"2026-05-25T00:46:43.047017Z","end":"2026-05-25T00:46:43.218881Z","steps":["trace[1986228270] 'agreement among raft nodes before linearized reading'  (duration: 171.716117ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:43.219071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.300398ms","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-25T00:46:43.219107Z","caller":"traceutil/trace.go:171","msg":"trace[122598847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4704; }","duration":"159.38233ms","start":"2026-05-25T00:46:43.059717Z","end":"2026-05-25T00:46:43.2191Z","steps":["trace[122598847] 'agreement among raft nodes before linearized reading'  (duration: 159.295638ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:43.628049Z","caller":"traceutil/trace.go:171","msg":"trace[1084774779] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"100.466037ms","start":"2026-05-25T00:46:43.52754Z","end":"2026-05-25T00:46:43.628006Z","steps":["trace[1084774779] 'process raft request'  (duration: 99.963076ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:43.856596Z","caller":"traceutil/trace.go:171","msg":"trace[1074172277] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"121.121031ms","start":"2026-05-25T00:46:43.735443Z","end":"2026-05-25T00:46:43.856564Z","steps":["trace[1074172277] 'process raft request'  (duration: 118.766358ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:43.85682Z","caller":"traceutil/trace.go:171","msg":"trace[8125474] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"120.726372ms","start":"2026-05-25T00:46:43.736075Z","end":"2026-05-25T00:46:43.856801Z","steps":["trace[8125474] 'process raft request'  (duration: 120.432586ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:43.858045Z","caller":"traceutil/trace.go:171","msg":"trace[1432493691] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"121.677073ms","start":"2026-05-25T00:46:43.735496Z","end":"2026-05-25T00:46:43.857173Z","steps":["trace[1432493691] 'process raft request'  (duration: 120.941437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:51.826581Z","caller":"traceutil/trace.go:171","msg":"trace[1412876988] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"111.53111ms","start":"2026-05-25T00:46:51.715028Z","end":"2026-05-25T00:46:51.826559Z","steps":["trace[1412876988] 'process raft request'  (duration: 32.400886ms)","trace[1412876988] 'compare'  (duration: 78.900849ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:46:51.826956Z","caller":"traceutil/trace.go:171","msg":"trace[130635919] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"109.168106ms","start":"2026-05-25T00:46:51.717781Z","end":"2026-05-25T00:46:51.826949Z","steps":["trace[130635919] 'process raft request'  (duration: 108.720446ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:51.826991Z","caller":"traceutil/trace.go:171","msg":"trace[1998144976] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5024; }","duration":"106.848473ms","start":"2026-05-25T00:46:51.720121Z","end":"2026-05-25T00:46:51.826969Z","steps":["trace[1998144976] 'read index received'  (duration: 27.31856ms)","trace[1998144976] 'applied index is now lower than readState.Index'  (duration: 79.529063ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T00:46:51.82723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.100358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-05-25T00:46:51.827262Z","caller":"traceutil/trace.go:171","msg":"trace[720451474] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4845; }","duration":"107.194661ms","start":"2026-05-25T00:46:51.72006Z","end":"2026-05-25T00:46:51.827255Z","steps":["trace[720451474] 'agreement among raft nodes before linearized reading'  (duration: 107.046968ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:51.827424Z","caller":"traceutil/trace.go:171","msg":"trace[865490160] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"108.223185ms","start":"2026-05-25T00:46:51.719194Z","end":"2026-05-25T00:46:51.827417Z","steps":["trace[865490160] 'process raft request'  (duration: 107.53451ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:55.861397Z","caller":"traceutil/trace.go:171","msg":"trace[1681429972] linearizableReadLoop","detail":"{readStateIndex:5060; appliedIndex:5059; }","duration":"211.56867ms","start":"2026-05-25T00:46:55.649802Z","end":"2026-05-25T00:46:55.861371Z","steps":["trace[1681429972] 'read index received'  (duration: 211.384515ms)","trace[1681429972] 'applied index is now lower than readState.Index'  (duration: 183.135µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:46:55.861429Z","caller":"traceutil/trace.go:171","msg":"trace[1354488682] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"286.446225ms","start":"2026-05-25T00:46:55.574955Z","end":"2026-05-25T00:46:55.861401Z","steps":["trace[1354488682] 'process raft request'  (duration: 286.250251ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:55.862083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.234244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"}
{"level":"info","ts":"2026-05-25T00:46:55.862529Z","caller":"traceutil/trace.go:171","msg":"trace[1418571735] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4878; }","duration":"212.758127ms","start":"2026-05-25T00:46:55.649756Z","end":"2026-05-25T00:46:55.862514Z","steps":["trace[1418571735] 'agreement among raft nodes before linearized reading'  (duration: 211.736803ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:46:55.86167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.542831ms","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-25T00:46:55.862643Z","caller":"traceutil/trace.go:171","msg":"trace[330166622] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4878; }","duration":"148.530854ms","start":"2026-05-25T00:46:55.714058Z","end":"2026-05-25T00:46:55.862589Z","steps":["trace[330166622] 'agreement among raft nodes before linearized reading'  (duration: 147.476289ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:56.073878Z","caller":"traceutil/trace.go:171","msg":"trace[987532687] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"125.691345ms","start":"2026-05-25T00:46:55.948159Z","end":"2026-05-25T00:46:56.07385Z","steps":["trace[987532687] 'process raft request'  (duration: 89.297955ms)","trace[987532687] 'compare'  (duration: 36.155045ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:46:56.074181Z","caller":"traceutil/trace.go:171","msg":"trace[1424495077] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"125.795007ms","start":"2026-05-25T00:46:55.948367Z","end":"2026-05-25T00:46:56.074162Z","steps":["trace[1424495077] 'process raft request'  (duration: 125.418079ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:56.074551Z","caller":"traceutil/trace.go:171","msg":"trace[926433095] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"126.017443ms","start":"2026-05-25T00:46:55.948526Z","end":"2026-05-25T00:46:56.074544Z","steps":["trace[926433095] 'process raft request'  (duration: 125.551462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:56.074762Z","caller":"traceutil/trace.go:171","msg":"trace[1993806849] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"126.136785ms","start":"2026-05-25T00:46:55.948619Z","end":"2026-05-25T00:46:56.074756Z","steps":["trace[1993806849] 'process raft request'  (duration: 125.835339ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:46:56.074944Z","caller":"traceutil/trace.go:171","msg":"trace[449178327] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"121.420317ms","start":"2026-05-25T00:46:55.953516Z","end":"2026-05-25T00:46:56.074936Z","steps":["trace[449178327] 'process raft request'  (duration: 121.139381ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:47:35.107803Z","caller":"traceutil/trace.go:171","msg":"trace[1388470541] linearizableReadLoop","detail":"{readStateIndex:5418; appliedIndex:5417; }","duration":"113.009434ms","start":"2026-05-25T00:47:34.994774Z","end":"2026-05-25T00:47:35.107784Z","steps":["trace[1388470541] 'read index received'  (duration: 112.895132ms)","trace[1388470541] 'applied index is now lower than readState.Index'  (duration: 113.332µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:47:35.107876Z","caller":"traceutil/trace.go:171","msg":"trace[240250101] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"306.985968ms","start":"2026-05-25T00:47:34.80086Z","end":"2026-05-25T00:47:35.107846Z","steps":["trace[240250101] 'process raft request'  (duration: 306.803374ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:47:35.107943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.159498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:47:35.107979Z","caller":"traceutil/trace.go:171","msg":"trace[1357393859] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:5227; }","duration":"113.24776ms","start":"2026-05-25T00:47:34.994721Z","end":"2026-05-25T00:47:35.107969Z","steps":["trace[1357393859] 'agreement among raft nodes before linearized reading'  (duration: 113.159058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:47:35.108027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T00:47:34.800845Z","time spent":"307.101391ms","remote":"127.0.0.1:40470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7438,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:5142 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7342 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >"}
{"level":"warn","ts":"2026-05-25T00:47:35.108045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.301722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:47:35.108305Z","caller":"traceutil/trace.go:171","msg":"trace[1142365222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5227; }","duration":"105.503977ms","start":"2026-05-25T00:47:35.002669Z","end":"2026-05-25T00:47:35.108173Z","steps":["trace[1142365222] 'agreement among raft nodes before linearized reading'  (duration: 105.290642ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:47:35.309061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.404989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T00:47:35.309153Z","caller":"traceutil/trace.go:171","msg":"trace[1476066994] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5227; }","duration":"120.552651ms","start":"2026-05-25T00:47:35.18858Z","end":"2026-05-25T00:47:35.309132Z","steps":["trace[1476066994] 'range keys from in-memory index tree'  (duration: 120.311246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:47:35.309222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.160513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-25T00:47:35.309294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.317343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"}
{"level":"info","ts":"2026-05-25T00:47:35.309358Z","caller":"traceutil/trace.go:171","msg":"trace[488300891] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5227; }","duration":"123.367938ms","start":"2026-05-25T00:47:35.185962Z","end":"2026-05-25T00:47:35.30933Z","steps":["trace[488300891] 'range keys from in-memory index tree'  (duration: 123.02269ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:47:35.309383Z","caller":"traceutil/trace.go:171","msg":"trace[114941952] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5227; }","duration":"119.452415ms","start":"2026-05-25T00:47:35.189911Z","end":"2026-05-25T00:47:35.309363Z","steps":["trace[114941952] 'range keys from in-memory index tree'  (duration: 119.137629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:47:45.67199Z","caller":"traceutil/trace.go:171","msg":"trace[527891512] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"130.823408ms","start":"2026-05-25T00:47:45.541144Z","end":"2026-05-25T00:47:45.671967Z","steps":["trace[527891512] 'process raft request'  (duration: 130.469899ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:47:45.817291Z","caller":"traceutil/trace.go:171","msg":"trace[380283070] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"139.834673ms","start":"2026-05-25T00:47:45.677427Z","end":"2026-05-25T00:47:45.817262Z","steps":["trace[380283070] 'process raft request'  (duration: 139.672539ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:47:45.817352Z","caller":"traceutil/trace.go:171","msg":"trace[1135525161] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"140.15646ms","start":"2026-05-25T00:47:45.677181Z","end":"2026-05-25T00:47:45.817337Z","steps":["trace[1135525161] 'process raft request'  (duration: 66.060004ms)","trace[1135525161] 'compare'  (duration: 73.705177ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:47:45.817427Z","caller":"traceutil/trace.go:171","msg":"trace[1924051647] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"138.963362ms","start":"2026-05-25T00:47:45.678454Z","end":"2026-05-25T00:47:45.817418Z","steps":["trace[1924051647] 'process raft request'  (duration: 138.719396ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:47:46.040256Z","caller":"traceutil/trace.go:171","msg":"trace[1385038854] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"216.49402ms","start":"2026-05-25T00:47:45.823739Z","end":"2026-05-25T00:47:46.040233Z","steps":["trace[1385038854] 'process raft request'  (duration: 164.206833ms)","trace[1385038854] 'compare'  (duration: 52.015641ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:48:17.925353Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855}
{"level":"info","ts":"2026-05-25T00:48:18.003104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"76.400968ms","hash":4043152370,"current-db-size-bytes":53989376,"current-db-size":"54 MB","current-db-size-in-use-bytes":29130752,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-25T00:48:18.003189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4043152370,"revision":2855,"compact-revision":-1}
{"level":"info","ts":"2026-05-25T00:50:28.784424Z","caller":"traceutil/trace.go:171","msg":"trace[1848755622] linearizableReadLoop","detail":"{readStateIndex:6679; appliedIndex:6676; }","duration":"110.570911ms","start":"2026-05-25T00:50:28.673825Z","end":"2026-05-25T00:50:28.784396Z","steps":["trace[1848755622] 'read index received'  (duration: 3.868229ms)","trace[1848755622] 'applied index is now lower than readState.Index'  (duration: 106.701582ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:50:28.784808Z","caller":"traceutil/trace.go:171","msg":"trace[2122541249] transaction","detail":"{read_only:false; response_revision:6446; number_of_response:1; }","duration":"111.728909ms","start":"2026-05-25T00:50:28.67306Z","end":"2026-05-25T00:50:28.784789Z","steps":["trace[2122541249] 'process raft request'  (duration: 111.270168ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:50:28.784912Z","caller":"traceutil/trace.go:171","msg":"trace[1920106875] transaction","detail":"{read_only:false; response_revision:6445; number_of_response:1; }","duration":"112.629082ms","start":"2026-05-25T00:50:28.672253Z","end":"2026-05-25T00:50:28.784882Z","steps":["trace[1920106875] 'process raft request'  (duration: 106.604409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:50:28.785201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.35783ms","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-25T00:50:28.785257Z","caller":"traceutil/trace.go:171","msg":"trace[445408621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6446; }","duration":"111.487323ms","start":"2026-05-25T00:50:28.673757Z","end":"2026-05-25T00:50:28.785244Z","steps":["trace[445408621] 'agreement among raft nodes before linearized reading'  (duration: 111.298648ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:50:28.787871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.143126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-25T00:50:28.788083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.346677ms","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-25T00:50:28.788114Z","caller":"traceutil/trace.go:171","msg":"trace[424449011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6447; }","duration":"113.219018ms","start":"2026-05-25T00:50:28.674698Z","end":"2026-05-25T00:50:28.787917Z","steps":["trace[424449011] 'agreement among raft nodes before linearized reading'  (duration: 113.020493ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:50:28.788166Z","caller":"traceutil/trace.go:171","msg":"trace[1321435997] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6447; }","duration":"105.45856ms","start":"2026-05-25T00:50:28.68269Z","end":"2026-05-25T00:50:28.788149Z","steps":["trace[1321435997] 'agreement among raft nodes before linearized reading'  (duration: 105.239635ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:53:10.716034Z","caller":"traceutil/trace.go:171","msg":"trace[2057462390] transaction","detail":"{read_only:false; response_revision:7347; number_of_response:1; }","duration":"298.425262ms","start":"2026-05-25T00:53:10.416693Z","end":"2026-05-25T00:53:10.715118Z","steps":["trace[2057462390] 'process raft request'  (duration: 298.291629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:53:17.936188Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5530}
{"level":"info","ts":"2026-05-25T00:53:18.026147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5530,"took":"87.468667ms","hash":1137795165,"current-db-size-bytes":53989376,"current-db-size":"54 MB","current-db-size-in-use-bytes":18153472,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-25T00:53:18.026207Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1137795165,"revision":5530,"compact-revision":2855}
{"level":"info","ts":"2026-05-25T00:53:29.595112Z","caller":"traceutil/trace.go:171","msg":"trace[281344373] transaction","detail":"{read_only:false; response_revision:7441; number_of_response:1; }","duration":"245.738722ms","start":"2026-05-25T00:53:29.349341Z","end":"2026-05-25T00:53:29.59508Z","steps":["trace[281344373] 'process raft request'  (duration: 245.580648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:53:29.937308Z","caller":"traceutil/trace.go:171","msg":"trace[650950359] transaction","detail":"{read_only:false; response_revision:7444; number_of_response:1; }","duration":"235.032179ms","start":"2026-05-25T00:53:29.702254Z","end":"2026-05-25T00:53:29.937286Z","steps":["trace[650950359] 'process raft request'  (duration: 234.876366ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:53:29.938753Z","caller":"traceutil/trace.go:171","msg":"trace[957065886] transaction","detail":"{read_only:false; response_revision:7446; number_of_response:1; }","duration":"235.271544ms","start":"2026-05-25T00:53:29.703455Z","end":"2026-05-25T00:53:29.938727Z","steps":["trace[957065886] 'process raft request'  (duration: 235.188612ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:53:29.938868Z","caller":"traceutil/trace.go:171","msg":"trace[1645751497] transaction","detail":"{read_only:false; response_revision:7445; number_of_response:1; }","duration":"235.625791ms","start":"2026-05-25T00:53:29.703214Z","end":"2026-05-25T00:53:29.93884Z","steps":["trace[1645751497] 'process raft request'  (duration: 235.289144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T00:53:29.93903Z","caller":"traceutil/trace.go:171","msg":"trace[6185736] linearizableReadLoop","detail":"{readStateIndex:7720; appliedIndex:7717; }","duration":"160.298487ms","start":"2026-05-25T00:53:29.778692Z","end":"2026-05-25T00:53:29.938991Z","steps":["trace[6185736] 'read index received'  (duration: 158.588241ms)","trace[6185736] 'applied index is now lower than readState.Index'  (duration: 1.708666ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T00:53:29.939048Z","caller":"traceutil/trace.go:171","msg":"trace[1405562219] transaction","detail":"{read_only:false; response_revision:7447; number_of_response:1; }","duration":"234.706963ms","start":"2026-05-25T00:53:29.704328Z","end":"2026-05-25T00:53:29.939035Z","steps":["trace[1405562219] 'process raft request'  (duration: 234.353356ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T00:53:29.939243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.527462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-25T00:53:29.939298Z","caller":"traceutil/trace.go:171","msg":"trace[363442669] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7447; }","duration":"160.623934ms","start":"2026-05-25T00:53:29.77866Z","end":"2026-05-25T00:53:29.939284Z","steps":["trace[363442669] 'agreement among raft nodes before linearized reading'  (duration: 160.42196ms)"],"step_count":1}