{"level":"warn","ts":"2026-07-10T21:27:51.413869Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-10T21:27:51.414017Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77: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.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77: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-07-10T21:27:51.414088Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-10T21:27:51.414102Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]}
{"level":"info","ts":"2026-07-10T21:27:51.414122Z","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-07-10T21:27:51.415026Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]}
{"level":"info","ts":"2026-07-10T21:27:51.41512Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77: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-07-10T21:27:51.418811Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.433256ms"}
{"level":"info","ts":"2026-07-10T21:27:51.425544Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"}
{"level":"info","ts":"2026-07-10T21:27:51.425694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"}
{"level":"info","ts":"2026-07-10T21:27:51.425746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"}
{"level":"info","ts":"2026-07-10T21:27:51.425768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-10T21:27:51.425784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"}
{"level":"info","ts":"2026-07-10T21:27:51.425833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"}
{"level":"warn","ts":"2026-07-10T21:27:51.431049Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-10T21:27:51.432323Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-10T21:27:51.433212Z","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-07-10T21:27:51.435567Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-10T21:27:51.436048Z","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-07-10T21:27:51.436143Z","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-07-10T21:27:51.436157Z","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-07-10T21:27:51.43602Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-10T21:27:51.438049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"}
{"level":"info","ts":"2026-07-10T21:27:51.438295Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]}
{"level":"info","ts":"2026-07-10T21:27:51.439876Z","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-07-10T21:27:51.440082Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"}
{"level":"info","ts":"2026-07-10T21:27:51.440116Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-10T21:27:51.440158Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-10T21:27:51.440115Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"}
{"level":"info","ts":"2026-07-10T21:27:52.227115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"}
{"level":"info","ts":"2026-07-10T21:27:52.22722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-10T21:27:52.227255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"}
{"level":"info","ts":"2026-07-10T21:27:52.227288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"}
{"level":"info","ts":"2026-07-10T21:27:52.227305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"}
{"level":"info","ts":"2026-07-10T21:27:52.227327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"}
{"level":"info","ts":"2026-07-10T21:27:52.227347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"}
{"level":"info","ts":"2026-07-10T21:27:52.228402Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-10T21:27:52.22863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-10T21:27:52.22863Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-10T21:27:52.228629Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-10T21:27:52.228975Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-10T21:27:52.229005Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-10T21:27:52.229466Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-10T21:27:52.229603Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-10T21:27:52.229653Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-10T21:27:52.230856Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-10T21:27:52.235935Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"}
{"level":"warn","ts":"2026-07-10T21:28:37.000106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.628605ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598812797 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:818 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-07-10T21:28:37.000294Z","caller":"traceutil/trace.go:171","msg":"trace[469288697] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"144.190729ms","start":"2026-07-10T21:28:36.85607Z","end":"2026-07-10T21:28:37.000261Z","steps":["trace[469288697] 'process raft request'  (duration: 28.818947ms)","trace[469288697] 'compare'  (duration: 114.440879ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:28:37.583128Z","caller":"traceutil/trace.go:171","msg":"trace[475400624] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"270.572039ms","start":"2026-07-10T21:28:37.312514Z","end":"2026-07-10T21:28:37.583086Z","steps":["trace[475400624] 'process raft request'  (duration: 270.312653ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:28:37.635349Z","caller":"traceutil/trace.go:171","msg":"trace[644117814] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"210.94316ms","start":"2026-07-10T21:28:37.42437Z","end":"2026-07-10T21:28:37.635313Z","steps":["trace[644117814] 'process raft request'  (duration: 210.424966ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:29:42.899345Z","caller":"traceutil/trace.go:171","msg":"trace[1577130391] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"133.202361ms","start":"2026-07-10T21:29:42.766122Z","end":"2026-07-10T21:29:42.899324Z","steps":["trace[1577130391] 'process raft request'  (duration: 133.047508ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:06.975616Z","caller":"traceutil/trace.go:171","msg":"trace[969646204] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"266.723975ms","start":"2026-07-10T21:30:06.708871Z","end":"2026-07-10T21:30:06.975595Z","steps":["trace[969646204] 'read index received'  (duration: 252.555019ms)","trace[969646204] 'applied index is now lower than readState.Index'  (duration: 14.168166ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:30:06.975803Z","caller":"traceutil/trace.go:171","msg":"trace[1830283764] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"269.81421ms","start":"2026-07-10T21:30:06.705947Z","end":"2026-07-10T21:30:06.975761Z","steps":["trace[1830283764] 'process raft request'  (duration: 255.48727ms)","trace[1830283764] 'compare'  (duration: 14.049824ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T21:30:06.975871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.223341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17b37d92-7817-4352-b69f-7d3d78181f32\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-07-10T21:30:06.975919Z","caller":"traceutil/trace.go:171","msg":"trace[1920399272] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-17b37d92-7817-4352-b69f-7d3d78181f32; range_end:; response_count:1; response_revision:1870; }","duration":"232.351414ms","start":"2026-07-10T21:30:06.743553Z","end":"2026-07-10T21:30:06.975905Z","steps":["trace[1920399272] 'agreement among raft nodes before linearized reading'  (duration: 232.168159ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:30:06.975913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.144756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17b37d92-7817-4352-b69f-7d3d78181f32\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-07-10T21:30:06.975906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.006482ms","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-07-10T21:30:06.975954Z","caller":"traceutil/trace.go:171","msg":"trace[522710431] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-17b37d92-7817-4352-b69f-7d3d78181f32; range_end:; response_count:1; response_revision:1870; }","duration":"153.210578ms","start":"2026-07-10T21:30:06.822734Z","end":"2026-07-10T21:30:06.975944Z","steps":["trace[522710431] 'agreement among raft nodes before linearized reading'  (duration: 153.111435ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:30:06.975931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.485734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-10T21:30:06.975998Z","caller":"traceutil/trace.go:171","msg":"trace[1527394140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1870; }","duration":"267.148045ms","start":"2026-07-10T21:30:06.708829Z","end":"2026-07-10T21:30:06.975977Z","steps":["trace[1527394140] 'agreement among raft nodes before linearized reading'  (duration: 266.886089ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:06.976023Z","caller":"traceutil/trace.go:171","msg":"trace[1668416039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1870; }","duration":"182.620227ms","start":"2026-07-10T21:30:06.793377Z","end":"2026-07-10T21:30:06.975997Z","steps":["trace[1668416039] 'agreement among raft nodes before linearized reading'  (duration: 182.474773ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:07.193807Z","caller":"traceutil/trace.go:171","msg":"trace[106929851] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"210.301535ms","start":"2026-07-10T21:30:06.983476Z","end":"2026-07-10T21:30:07.193777Z","steps":["trace[106929851] 'process raft request'  (duration: 210.11782ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:07.398467Z","caller":"traceutil/trace.go:171","msg":"trace[551591595] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"188.529852ms","start":"2026-07-10T21:30:07.209877Z","end":"2026-07-10T21:30:07.398407Z","steps":["trace[551591595] 'process raft request'  (duration: 183.723344ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:07.438584Z","caller":"traceutil/trace.go:171","msg":"trace[1893507508] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"187.140858ms","start":"2026-07-10T21:30:07.251388Z","end":"2026-07-10T21:30:07.438529Z","steps":["trace[1893507508] 'process raft request'  (duration: 186.839171ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:15.311186Z","caller":"traceutil/trace.go:171","msg":"trace[1110674196] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"147.342995ms","start":"2026-07-10T21:30:15.163802Z","end":"2026-07-10T21:30:15.311145Z","steps":["trace[1110674196] 'process raft request'  (duration: 147.099489ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:19.184616Z","caller":"traceutil/trace.go:171","msg":"trace[2003725412] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"149.516337ms","start":"2026-07-10T21:30:19.035069Z","end":"2026-07-10T21:30:19.184585Z","steps":["trace[2003725412] 'process raft request'  (duration: 149.307712ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:51.735312Z","caller":"traceutil/trace.go:171","msg":"trace[387171311] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"139.348599ms","start":"2026-07-10T21:30:51.595903Z","end":"2026-07-10T21:30:51.735251Z","steps":["trace[387171311] 'process raft request'  (duration: 109.95928ms)","trace[387171311] 'compare'  (duration: 29.031361ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:30:57.998486Z","caller":"traceutil/trace.go:171","msg":"trace[943879693] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"232.283592ms","start":"2026-07-10T21:30:57.766159Z","end":"2026-07-10T21:30:57.998443Z","steps":["trace[943879693] 'process raft request'  (duration: 166.115753ms)","trace[943879693] 'compare'  (duration: 65.899243ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:30:58.002224Z","caller":"traceutil/trace.go:171","msg":"trace[169384133] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"234.482537ms","start":"2026-07-10T21:30:57.767708Z","end":"2026-07-10T21:30:58.002191Z","steps":["trace[169384133] 'process raft request'  (duration: 234.244421ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:58.002429Z","caller":"traceutil/trace.go:171","msg":"trace[466035860] linearizableReadLoop","detail":"{readStateIndex:2281; appliedIndex:2279; }","duration":"208.721356ms","start":"2026-07-10T21:30:57.793659Z","end":"2026-07-10T21:30:58.00238Z","steps":["trace[466035860] 'read index received'  (duration: 138.634712ms)","trace[466035860] 'applied index is now lower than readState.Index'  (duration: 70.083164ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T21:30:58.002603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.90774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-10T21:30:58.002678Z","caller":"traceutil/trace.go:171","msg":"trace[1820100220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2200; }","duration":"209.058974ms","start":"2026-07-10T21:30:57.793603Z","end":"2026-07-10T21:30:58.002662Z","steps":["trace[1820100220] 'agreement among raft nodes before linearized reading'  (duration: 208.90419ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:30:58.002932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.347372ms","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-07-10T21:30:58.00301Z","caller":"traceutil/trace.go:171","msg":"trace[33903720] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2200; }","duration":"198.456915ms","start":"2026-07-10T21:30:57.804539Z","end":"2026-07-10T21:30:58.002995Z","steps":["trace[33903720] 'agreement among raft nodes before linearized reading'  (duration: 198.154608ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:30:58.160765Z","caller":"traceutil/trace.go:171","msg":"trace[1722542515] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"152.419469ms","start":"2026-07-10T21:30:58.008304Z","end":"2026-07-10T21:30:58.160724Z","steps":["trace[1722542515] 'process raft request'  (duration: 133.869405ms)","trace[1722542515] 'compare'  (duration: 18.404641ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:31:52.102621Z","caller":"traceutil/trace.go:171","msg":"trace[2051538577] transaction","detail":"{read_only:false; response_revision:2662; number_of_response:1; }","duration":"104.406653ms","start":"2026-07-10T21:31:51.998179Z","end":"2026-07-10T21:31:52.102586Z","steps":["trace[2051538577] 'process raft request'  (duration: 104.135057ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:35:01.027381Z","caller":"traceutil/trace.go:171","msg":"trace[1762698208] transaction","detail":"{read_only:false; response_revision:3885; number_of_response:1; }","duration":"134.06673ms","start":"2026-07-10T21:35:00.893285Z","end":"2026-07-10T21:35:01.027352Z","steps":["trace[1762698208] 'process raft request'  (duration: 134.017569ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:35:01.027507Z","caller":"traceutil/trace.go:171","msg":"trace[1497164599] transaction","detail":"{read_only:false; response_revision:3884; number_of_response:1; }","duration":"134.723436ms","start":"2026-07-10T21:35:00.892757Z","end":"2026-07-10T21:35:01.02748Z","steps":["trace[1497164599] 'process raft request'  (duration: 130.034472ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:31.39941Z","caller":"traceutil/trace.go:171","msg":"trace[632790384] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"170.416224ms","start":"2026-07-10T21:36:31.228959Z","end":"2026-07-10T21:36:31.399375Z","steps":["trace[632790384] 'process raft request'  (duration: 170.219849ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:31.41751Z","caller":"traceutil/trace.go:171","msg":"trace[539924457] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"187.710664ms","start":"2026-07-10T21:36:31.229765Z","end":"2026-07-10T21:36:31.417476Z","steps":["trace[539924457] 'process raft request'  (duration: 187.266284ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:31.417972Z","caller":"traceutil/trace.go:171","msg":"trace[409703823] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"178.272284ms","start":"2026-07-10T21:36:31.239686Z","end":"2026-07-10T21:36:31.417958Z","steps":["trace[409703823] 'process raft request'  (duration: 177.733671ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:31.674728Z","caller":"traceutil/trace.go:171","msg":"trace[1471587294] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"136.343044ms","start":"2026-07-10T21:36:31.538351Z","end":"2026-07-10T21:36:31.674694Z","steps":["trace[1471587294] 'process raft request'  (duration: 90.570529ms)","trace[1471587294] 'compare'  (duration: 45.396566ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:36:31.841889Z","caller":"traceutil/trace.go:171","msg":"trace[641800941] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"137.04513ms","start":"2026-07-10T21:36:31.704822Z","end":"2026-07-10T21:36:31.841867Z","steps":["trace[641800941] 'process raft request'  (duration: 136.771084ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:31.841932Z","caller":"traceutil/trace.go:171","msg":"trace[1404612315] transaction","detail":"{read_only:false; response_revision:5100; number_of_response:1; }","duration":"137.109372ms","start":"2026-07-10T21:36:31.704778Z","end":"2026-07-10T21:36:31.841888Z","steps":["trace[1404612315] 'process raft request'  (duration: 97.934767ms)","trace[1404612315] 'compare'  (duration: 38.704044ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T21:36:45.275087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.428295ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598823365 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5313 > 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-07-10T21:36:45.275366Z","caller":"traceutil/trace.go:171","msg":"trace[1434668764] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"130.162782ms","start":"2026-07-10T21:36:45.14518Z","end":"2026-07-10T21:36:45.275342Z","steps":["trace[1434668764] 'process raft request'  (duration: 130.07975ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:45.275378Z","caller":"traceutil/trace.go:171","msg":"trace[300641690] linearizableReadLoop","detail":"{readStateIndex:5554; appliedIndex:5553; }","duration":"140.454604ms","start":"2026-07-10T21:36:45.134884Z","end":"2026-07-10T21:36:45.275338Z","steps":["trace[300641690] 'read index received'  (duration: 37.531µs)","trace[300641690] 'applied index is now lower than readState.Index'  (duration: 140.413313ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:36:45.275366Z","caller":"traceutil/trace.go:171","msg":"trace[881783159] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"316.193087ms","start":"2026-07-10T21:36:44.959084Z","end":"2026-07-10T21:36:45.275277Z","steps":["trace[881783159] 'process raft request'  (duration: 122.25089ms)","trace[881783159] 'compare'  (duration: 193.160988ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T21:36:45.27566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.743205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-10T21:36:45.275707Z","caller":"traceutil/trace.go:171","msg":"trace[9146578] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5355; }","duration":"116.830947ms","start":"2026-07-10T21:36:45.158864Z","end":"2026-07-10T21:36:45.275695Z","steps":["trace[9146578] 'agreement among raft nodes before linearized reading'  (duration: 116.687284ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:36:45.275694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:36:44.959061Z","time spent":"316.465373ms","remote":"127.0.0.1:54306","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:5313 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-07-10T21:36:45.276005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.089459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-c9tgl\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-07-10T21:36:45.276146Z","caller":"traceutil/trace.go:171","msg":"trace[1931354722] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-c9tgl; range_end:; response_count:1; response_revision:5355; }","duration":"141.277113ms","start":"2026-07-10T21:36:45.134843Z","end":"2026-07-10T21:36:45.27612Z","steps":["trace[1931354722] 'agreement among raft nodes before linearized reading'  (duration: 140.679129ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:45.598389Z","caller":"traceutil/trace.go:171","msg":"trace[1039136175] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"310.836255ms","start":"2026-07-10T21:36:45.287502Z","end":"2026-07-10T21:36:45.598338Z","steps":["trace[1039136175] 'process raft request'  (duration: 308.922739ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:36:45.598415Z","caller":"traceutil/trace.go:171","msg":"trace[568178363] linearizableReadLoop","detail":"{readStateIndex:5556; appliedIndex:5555; }","duration":"270.143863ms","start":"2026-07-10T21:36:45.328146Z","end":"2026-07-10T21:36:45.59829Z","steps":["trace[568178363] 'read index received'  (duration: 267.798577ms)","trace[568178363] 'applied index is now lower than readState.Index'  (duration: 2.340006ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:36:45.598547Z","caller":"traceutil/trace.go:171","msg":"trace[409286787] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"117.675358ms","start":"2026-07-10T21:36:45.48084Z","end":"2026-07-10T21:36:45.598515Z","steps":["trace[409286787] 'process raft request'  (duration: 117.35111ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:36:45.598652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:36:45.287481Z","time spent":"311.01388ms","remote":"127.0.0.1:54224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8040,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-6479589586-c9tgl\" mod_revision:5339 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-c9tgl\" value_size:7971 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-c9tgl\" > >"}
{"level":"warn","ts":"2026-07-10T21:36:45.598908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.672457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-07-10T21:36:45.598986Z","caller":"traceutil/trace.go:171","msg":"trace[2035564377] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:5359; }","duration":"270.892003ms","start":"2026-07-10T21:36:45.328077Z","end":"2026-07-10T21:36:45.598969Z","steps":["trace[2035564377] 'agreement among raft nodes before linearized reading'  (duration: 270.563945ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:37:03.882972Z","caller":"traceutil/trace.go:171","msg":"trace[1754583041] transaction","detail":"{read_only:false; response_revision:5676; number_of_response:1; }","duration":"104.255021ms","start":"2026-07-10T21:37:03.778678Z","end":"2026-07-10T21:37:03.882933Z","steps":["trace[1754583041] 'process raft request'  (duration: 96.084393ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:37:52.256294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3012}
{"level":"info","ts":"2026-07-10T21:37:52.351879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3012,"took":"93.505039ms","hash":3945478913,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":31797248,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-10T21:37:52.351973Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3945478913,"revision":3012,"compact-revision":-1}
{"level":"info","ts":"2026-07-10T21:42:52.264221Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6088}
{"level":"info","ts":"2026-07-10T21:42:52.361315Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6088,"took":"94.986709ms","hash":2307218332,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":21999616,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-07-10T21:42:52.3614Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2307218332,"revision":6088,"compact-revision":3012}
{"level":"warn","ts":"2026-07-10T21:43:11.765046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.524107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-07-10T21:43:11.76513Z","caller":"traceutil/trace.go:171","msg":"trace[956491884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8414; }","duration":"409.68285ms","start":"2026-07-10T21:43:11.355428Z","end":"2026-07-10T21:43:11.765111Z","steps":["trace[956491884] 'range keys from in-memory index tree'  (duration: 409.369863ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:43:11.765165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:43:11.355403Z","time spent":"409.755621ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-10T21:43:11.765543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.080148ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598831235 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8407 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-10T21:43:11.765839Z","caller":"traceutil/trace.go:171","msg":"trace[1996451593] transaction","detail":"{read_only:false; response_revision:8415; number_of_response:1; }","duration":"319.341385ms","start":"2026-07-10T21:43:11.446432Z","end":"2026-07-10T21:43:11.765773Z","steps":["trace[1996451593] 'process raft request'  (duration: 151.910698ms)","trace[1996451593] 'compare'  (duration: 166.527504ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T21:43:11.766024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T21:43:11.446393Z","time spent":"319.53194ms","remote":"127.0.0.1:54306","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:8407 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-10T21:43:22.496849Z","caller":"traceutil/trace.go:171","msg":"trace[973173595] transaction","detail":"{read_only:false; response_revision:8471; number_of_response:1; }","duration":"215.006078ms","start":"2026-07-10T21:43:22.281814Z","end":"2026-07-10T21:43:22.49682Z","steps":["trace[973173595] 'process raft request'  (duration: 214.844945ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:23.319265Z","caller":"traceutil/trace.go:171","msg":"trace[235847562] transaction","detail":"{read_only:false; response_revision:8473; number_of_response:1; }","duration":"159.388611ms","start":"2026-07-10T21:43:23.159855Z","end":"2026-07-10T21:43:23.319244Z","steps":["trace[235847562] 'process raft request'  (duration: 159.258358ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:23.448012Z","caller":"traceutil/trace.go:171","msg":"trace[375573331] linearizableReadLoop","detail":"{readStateIndex:8772; appliedIndex:8770; }","duration":"147.756107ms","start":"2026-07-10T21:43:23.300235Z","end":"2026-07-10T21:43:23.447991Z","steps":["trace[375573331] 'read index received'  (duration: 18.902682ms)","trace[375573331] 'applied index is now lower than readState.Index'  (duration: 128.851825ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:43:23.448152Z","caller":"traceutil/trace.go:171","msg":"trace[1589822427] transaction","detail":"{read_only:false; response_revision:8474; number_of_response:1; }","duration":"277.842752ms","start":"2026-07-10T21:43:23.170276Z","end":"2026-07-10T21:43:23.448119Z","steps":["trace[1589822427] 'process raft request'  (duration: 272.085342ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:43:23.448246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.989333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-10T21:43:23.448294Z","caller":"traceutil/trace.go:171","msg":"trace[1857219613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8474; }","duration":"148.103425ms","start":"2026-07-10T21:43:23.300179Z","end":"2026-07-10T21:43:23.448282Z","steps":["trace[1857219613] 'agreement among raft nodes before linearized reading'  (duration: 147.89396ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:23.452515Z","caller":"traceutil/trace.go:171","msg":"trace[1533104769] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"106.89975ms","start":"2026-07-10T21:43:23.345597Z","end":"2026-07-10T21:43:23.452497Z","steps":["trace[1533104769] 'process raft request'  (duration: 106.819448ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:23.982953Z","caller":"traceutil/trace.go:171","msg":"trace[346562694] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"119.035867ms","start":"2026-07-10T21:43:23.863882Z","end":"2026-07-10T21:43:23.982918Z","steps":["trace[346562694] 'process raft request'  (duration: 66.719349ms)","trace[346562694] 'compare'  (duration: 52.151254ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:43:23.983482Z","caller":"traceutil/trace.go:171","msg":"trace[291027926] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"115.596982ms","start":"2026-07-10T21:43:23.86786Z","end":"2026-07-10T21:43:23.983457Z","steps":["trace[291027926] 'process raft request'  (duration: 115.015158ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:24.631642Z","caller":"traceutil/trace.go:171","msg":"trace[1179289713] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"126.281783ms","start":"2026-07-10T21:43:24.505334Z","end":"2026-07-10T21:43:24.631616Z","steps":["trace[1179289713] 'process raft request'  (duration: 126.126619ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:31.210968Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002277.wal"}
{"level":"info","ts":"2026-07-10T21:43:51.653906Z","caller":"traceutil/trace.go:171","msg":"trace[390574986] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"107.909913ms","start":"2026-07-10T21:43:51.545969Z","end":"2026-07-10T21:43:51.653879Z","steps":["trace[390574986] 'process raft request'  (duration: 102.187784ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:51.654042Z","caller":"traceutil/trace.go:171","msg":"trace[1761004838] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"106.875849ms","start":"2026-07-10T21:43:51.547146Z","end":"2026-07-10T21:43:51.654022Z","steps":["trace[1761004838] 'process raft request'  (duration: 106.455209ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:43:55.271631Z","caller":"traceutil/trace.go:171","msg":"trace[290598155] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"130.106747ms","start":"2026-07-10T21:43:55.1415Z","end":"2026-07-10T21:43:55.271607Z","steps":["trace[290598155] 'process raft request'  (duration: 129.951343ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:45:34.751665Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-10T21:45:34.757252Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-10T21:45:34.757458Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-10T21:47:52.270725Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8143}
{"level":"info","ts":"2026-07-10T21:47:52.335132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8143,"took":"62.299446ms","hash":942423047,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":28561408,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-07-10T21:47:52.335189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":942423047,"revision":8143,"compact-revision":6088}
{"level":"info","ts":"2026-07-10T21:50:59.831635Z","caller":"traceutil/trace.go:171","msg":"trace[1799248085] transaction","detail":"{read_only:false; response_revision:11978; number_of_response:1; }","duration":"227.888544ms","start":"2026-07-10T21:50:59.603713Z","end":"2026-07-10T21:50:59.831601Z","steps":["trace[1799248085] 'process raft request'  (duration: 227.73914ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:51:00.028751Z","caller":"traceutil/trace.go:171","msg":"trace[1154984361] transaction","detail":"{read_only:false; response_revision:11982; number_of_response:1; }","duration":"106.391717ms","start":"2026-07-10T21:50:59.922331Z","end":"2026-07-10T21:51:00.028723Z","steps":["trace[1154984361] 'process raft request'  (duration: 77.576734ms)","trace[1154984361] 'compare'  (duration: 28.69673ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:51:00.489438Z","caller":"traceutil/trace.go:171","msg":"trace[1851093364] transaction","detail":"{read_only:false; response_revision:11984; number_of_response:1; }","duration":"126.263413ms","start":"2026-07-10T21:51:00.363146Z","end":"2026-07-10T21:51:00.48941Z","steps":["trace[1851093364] 'process raft request'  (duration: 109.592536ms)","trace[1851093364] 'compare'  (duration: 16.487802ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T21:51:00.489837Z","caller":"traceutil/trace.go:171","msg":"trace[1281498174] transaction","detail":"{read_only:false; response_revision:11985; number_of_response:1; }","duration":"126.191401ms","start":"2026-07-10T21:51:00.363566Z","end":"2026-07-10T21:51:00.489757Z","steps":["trace[1281498174] 'process raft request'  (duration: 125.7897ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:51:00.938847Z","caller":"traceutil/trace.go:171","msg":"trace[1854788686] transaction","detail":"{read_only:false; response_revision:11986; number_of_response:1; }","duration":"182.522905ms","start":"2026-07-10T21:51:00.756297Z","end":"2026-07-10T21:51:00.93882Z","steps":["trace[1854788686] 'process raft request'  (duration: 182.31357ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:52:52.277973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10543}
{"level":"info","ts":"2026-07-10T21:52:52.359409Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10543,"took":"79.362586ms","hash":446580861,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":26689536,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-07-10T21:52:52.359488Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":446580861,"revision":10543,"compact-revision":8143}
{"level":"info","ts":"2026-07-10T21:57:03.147903Z","caller":"traceutil/trace.go:171","msg":"trace[312344206] transaction","detail":"{read_only:false; response_revision:14442; number_of_response:1; }","duration":"150.192095ms","start":"2026-07-10T21:57:02.997686Z","end":"2026-07-10T21:57:03.147878Z","steps":["trace[312344206] 'process raft request'  (duration: 150.011361ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:57:03.148486Z","caller":"traceutil/trace.go:171","msg":"trace[1916201626] linearizableReadLoop","detail":"{readStateIndex:14936; appliedIndex:14936; }","duration":"131.507579ms","start":"2026-07-10T21:57:03.016956Z","end":"2026-07-10T21:57:03.148464Z","steps":["trace[1916201626] 'read index received'  (duration: 131.497019ms)","trace[1916201626] 'applied index is now lower than readState.Index'  (duration: 8.94µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T21:57:03.148739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.764305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k5qns\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-07-10T21:57:03.148798Z","caller":"traceutil/trace.go:171","msg":"trace[1341446103] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k5qns; range_end:; response_count:1; response_revision:14442; }","duration":"131.879638ms","start":"2026-07-10T21:57:03.016904Z","end":"2026-07-10T21:57:03.148784Z","steps":["trace[1341446103] 'agreement among raft nodes before linearized reading'  (duration: 131.630402ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:57:40.2899Z","caller":"traceutil/trace.go:171","msg":"trace[1172546860] transaction","detail":"{read_only:false; response_revision:14649; number_of_response:1; }","duration":"102.810109ms","start":"2026-07-10T21:57:40.187032Z","end":"2026-07-10T21:57:40.289842Z","steps":["trace[1172546860] 'process raft request'  (duration: 96.260109ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:57:41.251307Z","caller":"traceutil/trace.go:171","msg":"trace[1081180202] transaction","detail":"{read_only:false; response_revision:14657; number_of_response:1; }","duration":"245.952831ms","start":"2026-07-10T21:57:41.005327Z","end":"2026-07-10T21:57:41.251279Z","steps":["trace[1081180202] 'process raft request'  (duration: 245.776627ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:57:52.288108Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12738}
{"level":"info","ts":"2026-07-10T21:57:52.366859Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12738,"took":"73.307199ms","hash":3018347112,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":27570176,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-07-10T21:57:52.366935Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3018347112,"revision":12738,"compact-revision":10543}
{"level":"info","ts":"2026-07-10T21:58:03.418242Z","caller":"traceutil/trace.go:171","msg":"trace[1912953966] transaction","detail":"{read_only:false; response_revision:14969; number_of_response:1; }","duration":"110.735373ms","start":"2026-07-10T21:58:03.307482Z","end":"2026-07-10T21:58:03.418217Z","steps":["trace[1912953966] 'process raft request'  (duration: 110.565409ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:58:03.511526Z","caller":"traceutil/trace.go:171","msg":"trace[507025976] transaction","detail":"{read_only:false; response_revision:14970; number_of_response:1; }","duration":"122.960412ms","start":"2026-07-10T21:58:03.388535Z","end":"2026-07-10T21:58:03.511495Z","steps":["trace[507025976] 'process raft request'  (duration: 118.692277ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:59:29.054152Z","caller":"traceutil/trace.go:171","msg":"trace[1507955900] transaction","detail":"{read_only:false; response_revision:15772; number_of_response:1; }","duration":"134.076522ms","start":"2026-07-10T21:59:28.920044Z","end":"2026-07-10T21:59:29.054121Z","steps":["trace[1507955900] 'process raft request'  (duration: 133.892858ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:59:29.353653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.226746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-10T21:59:29.353771Z","caller":"traceutil/trace.go:171","msg":"trace[1048960649] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15777; }","duration":"186.38461ms","start":"2026-07-10T21:59:29.16736Z","end":"2026-07-10T21:59:29.353744Z","steps":["trace[1048960649] 'range keys from in-memory index tree'  (duration: 186.140734ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:59:29.353818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.267557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-07-10T21:59:29.353829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.641932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-07-10T21:59:29.35391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.101638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-10T21:59:29.353939Z","caller":"traceutil/trace.go:171","msg":"trace[1673841790] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:15777; }","duration":"151.795386ms","start":"2026-07-10T21:59:29.202115Z","end":"2026-07-10T21:59:29.35391Z","steps":["trace[1673841790] 'range keys from in-memory index tree'  (duration: 151.470927ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:59:29.353989Z","caller":"traceutil/trace.go:171","msg":"trace[2021123642] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15777; }","duration":"201.208211ms","start":"2026-07-10T21:59:29.152762Z","end":"2026-07-10T21:59:29.35397Z","steps":["trace[2021123642] 'range keys from in-memory index tree'  (duration: 200.986066ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T21:59:29.354048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.226654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-07-10T21:59:29.354096Z","caller":"traceutil/trace.go:171","msg":"trace[1899702848] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15777; }","duration":"183.308676ms","start":"2026-07-10T21:59:29.170773Z","end":"2026-07-10T21:59:29.354082Z","steps":["trace[1899702848] 'range keys from in-memory index tree'  (duration: 183.11882ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T21:59:29.354408Z","caller":"traceutil/trace.go:171","msg":"trace[1202688224] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15777; }","duration":"186.39161ms","start":"2026-07-10T21:59:29.167474Z","end":"2026-07-10T21:59:29.353866Z","steps":["trace[1202688224] 'range keys from in-memory index tree'  (duration: 186.101513ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:02:52.295782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14755}
{"level":"info","ts":"2026-07-10T22:02:52.374007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14755,"took":"75.117613ms","hash":498952738,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":34545664,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-10T22:02:52.374073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":498952738,"revision":14755,"compact-revision":12738}
{"level":"warn","ts":"2026-07-10T22:05:38.584323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.7986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-10T22:05:38.584418Z","caller":"traceutil/trace.go:171","msg":"trace[1166513680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18544; }","duration":"204.930913ms","start":"2026-07-10T22:05:38.379469Z","end":"2026-07-10T22:05:38.5844Z","steps":["trace[1166513680] 'range keys from in-memory index tree'  (duration: 204.612355ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:05:38.747979Z","caller":"traceutil/trace.go:171","msg":"trace[1100644875] transaction","detail":"{read_only:false; response_revision:18547; number_of_response:1; }","duration":"159.429022ms","start":"2026-07-10T22:05:38.58852Z","end":"2026-07-10T22:05:38.747949Z","steps":["trace[1100644875] 'process raft request'  (duration: 159.31686ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:05:38.748069Z","caller":"traceutil/trace.go:171","msg":"trace[320379139] transaction","detail":"{read_only:false; response_revision:18546; number_of_response:1; }","duration":"185.074147ms","start":"2026-07-10T22:05:38.562956Z","end":"2026-07-10T22:05:38.74803Z","steps":["trace[320379139] 'process raft request'  (duration: 139.383562ms)","trace[320379139] 'compare'  (duration: 45.348777ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:05:38.748115Z","caller":"traceutil/trace.go:171","msg":"trace[1277458963] transaction","detail":"{read_only:false; response_revision:18548; number_of_response:1; }","duration":"156.915231ms","start":"2026-07-10T22:05:38.591168Z","end":"2026-07-10T22:05:38.748083Z","steps":["trace[1277458963] 'process raft request'  (duration: 156.717896ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:05:39.189378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.079203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-29728680-mh4hc\" ","response":"range_response_count:1 size:7033"}
{"level":"info","ts":"2026-07-10T22:05:39.18955Z","caller":"traceutil/trace.go:171","msg":"trace[791006425] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-29728680-mh4hc; range_end:; response_count:1; response_revision:18548; }","duration":"220.300268ms","start":"2026-07-10T22:05:38.969228Z","end":"2026-07-10T22:05:39.189528Z","steps":["trace[791006425] 'range keys from in-memory index tree'  (duration: 219.924369ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:05:39.189604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.754335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-07-10T22:05:39.18965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.146267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-10T22:05:39.189699Z","caller":"traceutil/trace.go:171","msg":"trace[1187635993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18548; }","duration":"185.912049ms","start":"2026-07-10T22:05:39.003768Z","end":"2026-07-10T22:05:39.18968Z","steps":["trace[1187635993] 'range keys from in-memory index tree'  (duration: 185.50736ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:05:39.189381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.462006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:05:39.189736Z","caller":"traceutil/trace.go:171","msg":"trace[492801388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18548; }","duration":"259.252209ms","start":"2026-07-10T22:05:38.930445Z","end":"2026-07-10T22:05:39.189698Z","steps":["trace[492801388] 'range keys from in-memory index tree'  (duration: 258.982242ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:05:39.189757Z","caller":"traceutil/trace.go:171","msg":"trace[1314152193] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:18548; }","duration":"112.852555ms","start":"2026-07-10T22:05:39.076887Z","end":"2026-07-10T22:05:39.189739Z","steps":["trace[1314152193] 'count revisions from in-memory index tree'  (duration: 112.325393ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:05:39.189784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.815227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-10T22:05:39.189852Z","caller":"traceutil/trace.go:171","msg":"trace[1440925058] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18548; }","duration":"285.93544ms","start":"2026-07-10T22:05:38.903899Z","end":"2026-07-10T22:05:39.189834Z","steps":["trace[1440925058] 'range keys from in-memory index tree'  (duration: 285.642832ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:06:54.359363Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-10T22:06:54.36533Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-10T22:06:54.365415Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-10T22:07:52.302741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17435}
{"level":"info","ts":"2026-07-10T22:07:52.400325Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17435,"took":"92.996473ms","hash":3940184713,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":35164160,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-07-10T22:07:52.400391Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3940184713,"revision":17435,"compact-revision":14755}
{"level":"info","ts":"2026-07-10T22:11:49.347785Z","caller":"traceutil/trace.go:171","msg":"trace[1265326370] linearizableReadLoop","detail":"{readStateIndex:22100; appliedIndex:22099; }","duration":"280.218737ms","start":"2026-07-10T22:11:49.067543Z","end":"2026-07-10T22:11:49.347762Z","steps":["trace[1265326370] 'read index received'  (duration: 280.028822ms)","trace[1265326370] 'applied index is now lower than readState.Index'  (duration: 189.195µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:11:49.347874Z","caller":"traceutil/trace.go:171","msg":"trace[1169397621] transaction","detail":"{read_only:false; response_revision:21378; number_of_response:1; }","duration":"282.022602ms","start":"2026-07-10T22:11:49.065823Z","end":"2026-07-10T22:11:49.347845Z","steps":["trace[1169397621] 'process raft request'  (duration: 281.801547ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:49.348014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.413232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:11:49.348113Z","caller":"traceutil/trace.go:171","msg":"trace[1792542181] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:21378; }","duration":"280.577506ms","start":"2026-07-10T22:11:49.067511Z","end":"2026-07-10T22:11:49.348088Z","steps":["trace[1792542181] 'agreement among raft nodes before linearized reading'  (duration: 280.377071ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:49.348045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.707277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-07-10T22:11:49.348199Z","caller":"traceutil/trace.go:171","msg":"trace[1503809619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21378; }","duration":"220.891501ms","start":"2026-07-10T22:11:49.127296Z","end":"2026-07-10T22:11:49.348187Z","steps":["trace[1503809619] 'agreement among raft nodes before linearized reading'  (duration: 220.600674ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:49.348191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.857296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-07-10T22:11:49.348209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.284476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-10T22:11:49.348251Z","caller":"traceutil/trace.go:171","msg":"trace[1263355577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21378; }","duration":"219.952087ms","start":"2026-07-10T22:11:49.128281Z","end":"2026-07-10T22:11:49.348233Z","steps":["trace[1263355577] 'agreement among raft nodes before linearized reading'  (duration: 219.710921ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:49.34824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.779963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-07-10T22:11:49.348301Z","caller":"traceutil/trace.go:171","msg":"trace[639392284] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21378; }","duration":"145.427229ms","start":"2026-07-10T22:11:49.202852Z","end":"2026-07-10T22:11:49.348279Z","steps":["trace[639392284] 'agreement among raft nodes before linearized reading'  (duration: 145.122912ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:11:49.348367Z","caller":"traceutil/trace.go:171","msg":"trace[1913439237] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:21378; }","duration":"102.974808ms","start":"2026-07-10T22:11:49.245365Z","end":"2026-07-10T22:11:49.34834Z","steps":["trace[1913439237] 'agreement among raft nodes before linearized reading'  (duration: 102.577518ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:11:49.553516Z","caller":"traceutil/trace.go:171","msg":"trace[1586534548] transaction","detail":"{read_only:false; response_revision:21380; number_of_response:1; }","duration":"200.039388ms","start":"2026-07-10T22:11:49.353453Z","end":"2026-07-10T22:11:49.553492Z","steps":["trace[1586534548] 'process raft request'  (duration: 199.978917ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:11:49.553693Z","caller":"traceutil/trace.go:171","msg":"trace[1814402144] linearizableReadLoop","detail":"{readStateIndex:22101; appliedIndex:22100; }","duration":"200.586424ms","start":"2026-07-10T22:11:49.353074Z","end":"2026-07-10T22:11:49.55366Z","steps":["trace[1814402144] 'read index received'  (duration: 112.678666ms)","trace[1814402144] 'applied index is now lower than readState.Index'  (duration: 87.905227ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:11:49.553704Z","caller":"traceutil/trace.go:171","msg":"trace[1744344210] transaction","detail":"{read_only:false; response_revision:21379; number_of_response:1; }","duration":"201.28884ms","start":"2026-07-10T22:11:49.352376Z","end":"2026-07-10T22:11:49.553664Z","steps":["trace[1744344210] 'process raft request'  (duration: 113.360811ms)","trace[1744344210] 'compare'  (duration: 87.272242ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:11:49.553928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.826119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-10T22:11:49.554062Z","caller":"traceutil/trace.go:171","msg":"trace[1973167305] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21380; }","duration":"201.026094ms","start":"2026-07-10T22:11:49.353021Z","end":"2026-07-10T22:11:49.554047Z","steps":["trace[1973167305] 'agreement among raft nodes before linearized reading'  (duration: 200.737647ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:11:49.631053Z","caller":"traceutil/trace.go:171","msg":"trace[899967442] transaction","detail":"{read_only:false; response_revision:21381; number_of_response:1; }","duration":"111.435835ms","start":"2026-07-10T22:11:49.519573Z","end":"2026-07-10T22:11:49.631009Z","steps":["trace[899967442] 'process raft request'  (duration: 111.242241ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:49.81792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.422935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:11:49.818104Z","caller":"traceutil/trace.go:171","msg":"trace[1832801204] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21381; }","duration":"124.616889ms","start":"2026-07-10T22:11:49.693405Z","end":"2026-07-10T22:11:49.818022Z","steps":["trace[1832801204] 'range keys from in-memory index tree'  (duration: 124.332163ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:50.14686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.750463ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598871548 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:21371 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:11:50.14697Z","caller":"traceutil/trace.go:171","msg":"trace[1615234974] transaction","detail":"{read_only:false; response_revision:21383; number_of_response:1; }","duration":"199.870035ms","start":"2026-07-10T22:11:49.94708Z","end":"2026-07-10T22:11:50.14695Z","steps":["trace[1615234974] 'process raft request'  (duration: 78.946227ms)","trace[1615234974] 'compare'  (duration: 120.630831ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:11:50.396498Z","caller":"traceutil/trace.go:171","msg":"trace[1962881858] transaction","detail":"{read_only:false; response_revision:21384; number_of_response:1; }","duration":"307.153088ms","start":"2026-07-10T22:11:50.089307Z","end":"2026-07-10T22:11:50.396461Z","steps":["trace[1962881858] 'process raft request'  (duration: 212.691251ms)","trace[1962881858] 'compare'  (duration: 94.281203ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:11:50.39668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:11:50.089277Z","time spent":"307.308141ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:21372 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-10T22:11:50.618488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.313248ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598871550 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21373 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:11:50.618642Z","caller":"traceutil/trace.go:171","msg":"trace[796086168] linearizableReadLoop","detail":"{readStateIndex:22107; appliedIndex:22105; }","duration":"491.169476ms","start":"2026-07-10T22:11:50.12745Z","end":"2026-07-10T22:11:50.618619Z","steps":["trace[796086168] 'read index received'  (duration: 174.528554ms)","trace[796086168] 'applied index is now lower than readState.Index'  (duration: 316.638511ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:11:50.618663Z","caller":"traceutil/trace.go:171","msg":"trace[973326743] transaction","detail":"{read_only:false; response_revision:21385; number_of_response:1; }","duration":"516.957638ms","start":"2026-07-10T22:11:50.101665Z","end":"2026-07-10T22:11:50.618623Z","steps":["trace[973326743] 'process raft request'  (duration: 395.392923ms)","trace[973326743] 'compare'  (duration: 121.062441ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:11:50.61877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.306659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-10T22:11:50.618836Z","caller":"traceutil/trace.go:171","msg":"trace[628401564] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:21385; }","duration":"491.433502ms","start":"2026-07-10T22:11:50.127382Z","end":"2026-07-10T22:11:50.618816Z","steps":["trace[628401564] 'agreement among raft nodes before linearized reading'  (duration: 491.299109ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:11:50.618832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:11:50.101642Z","time spent":"517.100142ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21373 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-10T22:11:50.618878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:11:50.12736Z","time spent":"491.508064ms","remote":"127.0.0.1:41326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "}
{"level":"info","ts":"2026-07-10T22:12:52.309818Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19766}
{"level":"info","ts":"2026-07-10T22:12:52.421745Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19766,"took":"108.906343ms","hash":2014476335,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":30216192,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-10T22:12:52.421794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2014476335,"revision":19766,"compact-revision":17435}
{"level":"info","ts":"2026-07-10T22:15:45.126304Z","caller":"traceutil/trace.go:171","msg":"trace[880347756] transaction","detail":"{read_only:false; response_revision:23866; number_of_response:1; }","duration":"204.281468ms","start":"2026-07-10T22:15:44.921985Z","end":"2026-07-10T22:15:45.126266Z","steps":["trace[880347756] 'process raft request'  (duration: 164.952098ms)","trace[880347756] 'compare'  (duration: 39.120995ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:15:45.12797Z","caller":"traceutil/trace.go:171","msg":"trace[1162242242] transaction","detail":"{read_only:false; response_revision:23868; number_of_response:1; }","duration":"176.197332ms","start":"2026-07-10T22:15:44.951748Z","end":"2026-07-10T22:15:45.127945Z","steps":["trace[1162242242] 'process raft request'  (duration: 175.963686ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:15:45.128175Z","caller":"traceutil/trace.go:171","msg":"trace[1314022710] transaction","detail":"{read_only:false; response_revision:23869; number_of_response:1; }","duration":"100.565466ms","start":"2026-07-10T22:15:45.027591Z","end":"2026-07-10T22:15:45.128157Z","steps":["trace[1314022710] 'process raft request'  (duration: 100.258668ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:15:45.127995Z","caller":"traceutil/trace.go:171","msg":"trace[58771397] transaction","detail":"{read_only:false; response_revision:23867; number_of_response:1; }","duration":"204.652687ms","start":"2026-07-10T22:15:44.923229Z","end":"2026-07-10T22:15:45.127882Z","steps":["trace[58771397] 'process raft request'  (duration: 204.298869ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:17:52.31576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21976}
{"level":"info","ts":"2026-07-10T22:17:52.430167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21976,"took":"110.518488ms","hash":4099008164,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":45019136,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-07-10T22:17:52.430226Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4099008164,"revision":21976,"compact-revision":19766}
{"level":"info","ts":"2026-07-10T22:18:22.591635Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000668d.wal"}
{"level":"info","ts":"2026-07-10T22:18:57.998418Z","caller":"traceutil/trace.go:171","msg":"trace[1385401002] transaction","detail":"{read_only:false; response_revision:25823; number_of_response:1; }","duration":"124.055818ms","start":"2026-07-10T22:18:57.874337Z","end":"2026-07-10T22:18:57.998393Z","steps":["trace[1385401002] 'process raft request'  (duration: 123.932975ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:18:58.11233Z","caller":"traceutil/trace.go:171","msg":"trace[2114953174] linearizableReadLoop","detail":"{readStateIndex:26668; appliedIndex:26667; }","duration":"217.775297ms","start":"2026-07-10T22:18:57.894534Z","end":"2026-07-10T22:18:58.11231Z","steps":["trace[2114953174] 'read index received'  (duration: 104.495131ms)","trace[2114953174] 'applied index is now lower than readState.Index'  (duration: 113.279536ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:18:58.112789Z","caller":"traceutil/trace.go:171","msg":"trace[106036297] transaction","detail":"{read_only:false; response_revision:25825; number_of_response:1; }","duration":"145.970073ms","start":"2026-07-10T22:18:57.966804Z","end":"2026-07-10T22:18:58.112774Z","steps":["trace[106036297] 'process raft request'  (duration: 145.462271ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:58.11319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.648289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-10T22:18:58.112771Z","caller":"traceutil/trace.go:171","msg":"trace[507147055] transaction","detail":"{read_only:false; response_revision:25824; number_of_response:1; }","duration":"236.126115ms","start":"2026-07-10T22:18:57.876583Z","end":"2026-07-10T22:18:58.112709Z","steps":["trace[507147055] 'process raft request'  (duration: 229.609156ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:18:58.113223Z","caller":"traceutil/trace.go:171","msg":"trace[816033232] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25825; }","duration":"218.72821ms","start":"2026-07-10T22:18:57.894487Z","end":"2026-07-10T22:18:58.113215Z","steps":["trace[816033232] 'agreement among raft nodes before linearized reading'  (duration: 217.89762ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:18:58.386526Z","caller":"traceutil/trace.go:171","msg":"trace[1892204453] transaction","detail":"{read_only:false; response_revision:25826; number_of_response:1; }","duration":"234.736012ms","start":"2026-07-10T22:18:58.151767Z","end":"2026-07-10T22:18:58.386503Z","steps":["trace[1892204453] 'process raft request'  (duration: 234.595378ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:58.572847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.262314ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883364 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25809 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:18:58.572946Z","caller":"traceutil/trace.go:171","msg":"trace[1163339239] linearizableReadLoop","detail":"{readStateIndex:26671; appliedIndex:26669; }","duration":"362.49649ms","start":"2026-07-10T22:18:58.210434Z","end":"2026-07-10T22:18:58.572931Z","steps":["trace[1163339239] 'read index received'  (duration: 175.866984ms)","trace[1163339239] 'applied index is now lower than readState.Index'  (duration: 186.628496ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:18:58.573182Z","caller":"traceutil/trace.go:171","msg":"trace[101614498] transaction","detail":"{read_only:false; response_revision:25827; number_of_response:1; }","duration":"413.424933ms","start":"2026-07-10T22:18:58.159731Z","end":"2026-07-10T22:18:58.573156Z","steps":["trace[101614498] 'process raft request'  (duration: 263.76759ms)","trace[101614498] 'compare'  (duration: 149.044769ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:18:58.573245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:18:58.159709Z","time spent":"413.507016ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25809 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-07-10T22:18:58.573404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.969941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:18:58.57343Z","caller":"traceutil/trace.go:171","msg":"trace[2060740291] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25827; }","duration":"363.036413ms","start":"2026-07-10T22:18:58.210387Z","end":"2026-07-10T22:18:58.573424Z","steps":["trace[2060740291] 'agreement among raft nodes before linearized reading'  (duration: 362.989042ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:58.573451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:18:58.210367Z","time spent":"363.080115ms","remote":"127.0.0.1:50288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-07-10T22:18:58.573751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.260795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-10T22:18:58.573829Z","caller":"traceutil/trace.go:171","msg":"trace[867195799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25827; }","duration":"244.385977ms","start":"2026-07-10T22:18:58.329425Z","end":"2026-07-10T22:18:58.573811Z","steps":["trace[867195799] 'agreement among raft nodes before linearized reading'  (duration: 244.153662ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:58.831876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.8405ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883368 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25814 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:18:58.8321Z","caller":"traceutil/trace.go:171","msg":"trace[771634191] transaction","detail":"{read_only:false; response_revision:25828; number_of_response:1; }","duration":"254.77342ms","start":"2026-07-10T22:18:58.577296Z","end":"2026-07-10T22:18:58.832069Z","steps":["trace[771634191] 'process raft request'  (duration: 133.656904ms)","trace[771634191] 'compare'  (duration: 120.497591ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:18:58.832246Z","caller":"traceutil/trace.go:171","msg":"trace[1363351210] transaction","detail":"{read_only:false; response_revision:25829; number_of_response:1; }","duration":"242.743747ms","start":"2026-07-10T22:18:58.589461Z","end":"2026-07-10T22:18:58.832205Z","steps":["trace[1363351210] 'process raft request'  (duration: 242.525591ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:18:58.832416Z","caller":"traceutil/trace.go:171","msg":"trace[833253276] linearizableReadLoop","detail":"{readStateIndex:26672; appliedIndex:26671; }","duration":"249.158723ms","start":"2026-07-10T22:18:58.583241Z","end":"2026-07-10T22:18:58.8324Z","steps":["trace[833253276] 'read index received'  (duration: 127.726319ms)","trace[833253276] 'applied index is now lower than readState.Index'  (duration: 121.431034ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:18:58.832835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.584583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-10T22:18:58.832876Z","caller":"traceutil/trace.go:171","msg":"trace[195450155] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25829; }","duration":"249.660275ms","start":"2026-07-10T22:18:58.583203Z","end":"2026-07-10T22:18:58.832864Z","steps":["trace[195450155] 'agreement among raft nodes before linearized reading'  (duration: 249.466381ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:18:59.073481Z","caller":"traceutil/trace.go:171","msg":"trace[590401200] linearizableReadLoop","detail":"{readStateIndex:26674; appliedIndex:26673; }","duration":"224.906041ms","start":"2026-07-10T22:18:58.848555Z","end":"2026-07-10T22:18:59.073461Z","steps":["trace[590401200] 'read index received'  (duration: 135.042027ms)","trace[590401200] 'applied index is now lower than readState.Index'  (duration: 89.809412ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:18:59.073641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.073035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-07-10T22:18:59.073676Z","caller":"traceutil/trace.go:171","msg":"trace[775515320] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25830; }","duration":"225.152117ms","start":"2026-07-10T22:18:58.848517Z","end":"2026-07-10T22:18:59.073669Z","steps":["trace[775515320] 'agreement among raft nodes before linearized reading'  (duration: 225.010053ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:18:59.074116Z","caller":"traceutil/trace.go:171","msg":"trace[1706908350] transaction","detail":"{read_only:false; response_revision:25830; number_of_response:1; }","duration":"235.792066ms","start":"2026-07-10T22:18:58.838241Z","end":"2026-07-10T22:18:59.074033Z","steps":["trace[1706908350] 'process raft request'  (duration: 145.41543ms)","trace[1706908350] 'compare'  (duration: 89.508186ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:18:59.442979Z","caller":"traceutil/trace.go:171","msg":"trace[754667051] transaction","detail":"{read_only:false; response_revision:25831; number_of_response:1; }","duration":"304.816792ms","start":"2026-07-10T22:18:59.13814Z","end":"2026-07-10T22:18:59.442957Z","steps":["trace[754667051] 'process raft request'  (duration: 304.675789ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:59.443119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:18:59.138115Z","time spent":"304.933555ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25818 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-10T22:18:59.490055Z","caller":"traceutil/trace.go:171","msg":"trace[1670868539] transaction","detail":"{read_only:false; response_revision:25832; number_of_response:1; }","duration":"326.358909ms","start":"2026-07-10T22:18:59.163675Z","end":"2026-07-10T22:18:59.490034Z","steps":["trace[1670868539] 'process raft request'  (duration: 326.236176ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:59.490221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:18:59.163654Z","time spent":"326.484222ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25639 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-07-10T22:18:59.689494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.101913ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883378 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:25601 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:18:59.689926Z","caller":"traceutil/trace.go:171","msg":"trace[951512916] transaction","detail":"{read_only:false; response_revision:25833; number_of_response:1; }","duration":"205.948188ms","start":"2026-07-10T22:18:59.483946Z","end":"2026-07-10T22:18:59.689894Z","steps":["trace[951512916] 'process raft request'  (duration: 17.320183ms)","trace[951512916] 'compare'  (duration: 187.797915ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:18:59.690025Z","caller":"traceutil/trace.go:171","msg":"trace[581765031] linearizableReadLoop","detail":"{readStateIndex:26678; appliedIndex:26676; }","duration":"195.097894ms","start":"2026-07-10T22:18:59.494909Z","end":"2026-07-10T22:18:59.690007Z","steps":["trace[581765031] 'read index received'  (duration: 6.301785ms)","trace[581765031] 'applied index is now lower than readState.Index'  (duration: 188.795059ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:18:59.690049Z","caller":"traceutil/trace.go:171","msg":"trace[1854068285] transaction","detail":"{read_only:false; response_revision:25834; number_of_response:1; }","duration":"201.445328ms","start":"2026-07-10T22:18:59.488576Z","end":"2026-07-10T22:18:59.690022Z","steps":["trace[1854068285] 'process raft request'  (duration: 201.310475ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:18:59.690208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.286928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-10T22:18:59.69027Z","caller":"traceutil/trace.go:171","msg":"trace[1530215811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25834; }","duration":"195.397181ms","start":"2026-07-10T22:18:59.494858Z","end":"2026-07-10T22:18:59.690255Z","steps":["trace[1530215811] 'agreement among raft nodes before linearized reading'  (duration: 195.223917ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.060682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.605341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:05.060773Z","caller":"traceutil/trace.go:171","msg":"trace[2132331774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25887; }","duration":"271.729964ms","start":"2026-07-10T22:19:04.78902Z","end":"2026-07-10T22:19:05.060749Z","steps":["trace[2132331774] 'count revisions from in-memory index tree'  (duration: 271.54599ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.061239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.717633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-10T22:19:05.061336Z","caller":"traceutil/trace.go:171","msg":"trace[910285869] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25887; }","duration":"253.826746ms","start":"2026-07-10T22:19:04.807487Z","end":"2026-07-10T22:19:05.061314Z","steps":["trace[910285869] 'count revisions from in-memory index tree'  (duration: 253.619201ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:05.075562Z","caller":"traceutil/trace.go:171","msg":"trace[1963518052] transaction","detail":"{read_only:false; response_revision:25888; number_of_response:1; }","duration":"226.46975ms","start":"2026-07-10T22:19:04.849073Z","end":"2026-07-10T22:19:05.075543Z","steps":["trace[1963518052] 'process raft request'  (duration: 226.347076ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.382318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.008657ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883490 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25838 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:05.382428Z","caller":"traceutil/trace.go:171","msg":"trace[2110581050] linearizableReadLoop","detail":"{readStateIndex:26734; appliedIndex:26732; }","duration":"525.266424ms","start":"2026-07-10T22:19:04.857145Z","end":"2026-07-10T22:19:05.382411Z","steps":["trace[2110581050] 'read index received'  (duration: 218.357402ms)","trace[2110581050] 'applied index is now lower than readState.Index'  (duration: 306.907532ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:05.382525Z","caller":"traceutil/trace.go:171","msg":"trace[1481175056] transaction","detail":"{read_only:false; response_revision:25889; number_of_response:1; }","duration":"533.149087ms","start":"2026-07-10T22:19:04.849363Z","end":"2026-07-10T22:19:05.382512Z","steps":["trace[1481175056] 'process raft request'  (duration: 372.858883ms)","trace[1481175056] 'compare'  (duration: 159.369822ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:05.382622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:04.849351Z","time spent":"533.207378ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25838 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:05.382708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.724967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:05.382771Z","caller":"traceutil/trace.go:171","msg":"trace[551858566] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:25889; }","duration":"523.84515ms","start":"2026-07-10T22:19:04.858912Z","end":"2026-07-10T22:19:05.382757Z","steps":["trace[551858566] 'agreement among raft nodes before linearized reading'  (duration: 523.739717ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.382804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:04.85889Z","time spent":"523.906742ms","remote":"127.0.0.1:54418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-07-10T22:19:05.382809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.918348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:05.382896Z","caller":"traceutil/trace.go:171","msg":"trace[1303959005] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25889; }","duration":"188.049031ms","start":"2026-07-10T22:19:05.194824Z","end":"2026-07-10T22:19:05.382873Z","steps":["trace[1303959005] 'agreement among raft nodes before linearized reading'  (duration: 187.889828ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.382955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.829351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-10T22:19:05.383018Z","caller":"traceutil/trace.go:171","msg":"trace[368961296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25889; }","duration":"290.939024ms","start":"2026-07-10T22:19:05.092065Z","end":"2026-07-10T22:19:05.383004Z","steps":["trace[368961296] 'agreement among raft nodes before linearized reading'  (duration: 290.727948ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.382992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.913101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-10T22:19:05.383162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.94458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-10T22:19:05.383213Z","caller":"traceutil/trace.go:171","msg":"trace[2081920225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25889; }","duration":"526.106844ms","start":"2026-07-10T22:19:04.857092Z","end":"2026-07-10T22:19:05.383199Z","steps":["trace[2081920225] 'agreement among raft nodes before linearized reading'  (duration: 525.863708ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:05.383228Z","caller":"traceutil/trace.go:171","msg":"trace[261057816] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:25889; }","duration":"449.200367ms","start":"2026-07-10T22:19:04.933982Z","end":"2026-07-10T22:19:05.383182Z","steps":["trace[261057816] 'agreement among raft nodes before linearized reading'  (duration: 448.836308ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.383269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:04.857075Z","time spent":"526.176376ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-10T22:19:05.383321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:04.933966Z","time spent":"449.335081ms","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "}
{"level":"info","ts":"2026-07-10T22:19:05.623627Z","caller":"traceutil/trace.go:171","msg":"trace[1506894295] transaction","detail":"{read_only:false; response_revision:25890; number_of_response:1; }","duration":"235.929589ms","start":"2026-07-10T22:19:05.38766Z","end":"2026-07-10T22:19:05.62359Z","steps":["trace[1506894295] 'process raft request'  (duration: 146.638399ms)","trace[1506894295] 'compare'  (duration: 89.136477ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:05.951209Z","caller":"traceutil/trace.go:171","msg":"trace[1730015374] transaction","detail":"{read_only:false; response_revision:25891; number_of_response:1; }","duration":"559.88001ms","start":"2026-07-10T22:19:05.391304Z","end":"2026-07-10T22:19:05.951184Z","steps":["trace[1730015374] 'process raft request'  (duration: 515.186198ms)","trace[1730015374] 'compare'  (duration: 44.550058ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:05.951326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:05.391229Z","time spent":"560.035794ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25875 > 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-07-10T22:19:05.951396Z","caller":"traceutil/trace.go:171","msg":"trace[1826738957] transaction","detail":"{read_only:false; response_revision:25892; number_of_response:1; }","duration":"491.174122ms","start":"2026-07-10T22:19:05.460184Z","end":"2026-07-10T22:19:05.951358Z","steps":["trace[1826738957] 'process raft request'  (duration: 490.968277ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:05.951445Z","caller":"traceutil/trace.go:171","msg":"trace[1074496747] linearizableReadLoop","detail":"{readStateIndex:26737; appliedIndex:26734; }","duration":"476.947634ms","start":"2026-07-10T22:19:05.474476Z","end":"2026-07-10T22:19:05.951423Z","steps":["trace[1074496747] 'read index received'  (duration: 59.917473ms)","trace[1074496747] 'applied index is now lower than readState.Index'  (duration: 417.026821ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:05.95147Z","caller":"traceutil/trace.go:171","msg":"trace[2024492356] transaction","detail":"{read_only:false; response_revision:25893; number_of_response:1; }","duration":"239.938957ms","start":"2026-07-10T22:19:05.711507Z","end":"2026-07-10T22:19:05.951446Z","steps":["trace[2024492356] 'process raft request'  (duration: 239.830454ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.951596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.120478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:137"}
{"level":"warn","ts":"2026-07-10T22:19:05.951587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:05.460159Z","time spent":"491.315206ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25877 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-10T22:19:05.951621Z","caller":"traceutil/trace.go:171","msg":"trace[574041584] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:25893; }","duration":"477.18155ms","start":"2026-07-10T22:19:05.474432Z","end":"2026-07-10T22:19:05.951613Z","steps":["trace[574041584] 'agreement among raft nodes before linearized reading'  (duration: 477.091208ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.951632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.936575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-07-10T22:19:05.95164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:05.474415Z","time spent":"477.221461ms","remote":"127.0.0.1:54084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/199.204.45.77\" "}
{"level":"info","ts":"2026-07-10T22:19:05.951669Z","caller":"traceutil/trace.go:171","msg":"trace[1112996521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25893; }","duration":"226.075789ms","start":"2026-07-10T22:19:05.725582Z","end":"2026-07-10T22:19:05.951658Z","steps":["trace[1112996521] 'agreement among raft nodes before linearized reading'  (duration: 225.966386ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.951655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.14266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:05.951726Z","caller":"traceutil/trace.go:171","msg":"trace[597307105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25893; }","duration":"160.245232ms","start":"2026-07-10T22:19:05.79146Z","end":"2026-07-10T22:19:05.951705Z","steps":["trace[597307105] 'agreement among raft nodes before linearized reading'  (duration: 160.14053ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.951716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.677719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-10T22:19:05.951783Z","caller":"traceutil/trace.go:171","msg":"trace[866292097] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25893; }","duration":"157.791612ms","start":"2026-07-10T22:19:05.793974Z","end":"2026-07-10T22:19:05.951766Z","steps":["trace[866292097] 'agreement among raft nodes before linearized reading'  (duration: 157.591877ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.951796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.879079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:05.951851Z","caller":"traceutil/trace.go:171","msg":"trace[1024781299] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:25893; }","duration":"201.972081ms","start":"2026-07-10T22:19:05.749858Z","end":"2026-07-10T22:19:05.95183Z","steps":["trace[1024781299] 'agreement among raft nodes before linearized reading'  (duration: 201.874759ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:05.951879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.068219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-10T22:19:05.951903Z","caller":"traceutil/trace.go:171","msg":"trace[670332094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25893; }","duration":"122.115871ms","start":"2026-07-10T22:19:05.82978Z","end":"2026-07-10T22:19:05.951896Z","steps":["trace[670332094] 'agreement among raft nodes before linearized reading'  (duration: 122.047799ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:06.249015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.153987ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883499 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25879 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:06.249188Z","caller":"traceutil/trace.go:171","msg":"trace[922564476] transaction","detail":"{read_only:false; response_revision:25894; number_of_response:1; }","duration":"291.214069ms","start":"2026-07-10T22:19:05.957939Z","end":"2026-07-10T22:19:06.249153Z","steps":["trace[922564476] 'process raft request'  (duration: 126.855217ms)","trace[922564476] 'compare'  (duration: 163.962773ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:06.249283Z","caller":"traceutil/trace.go:171","msg":"trace[1866487041] transaction","detail":"{read_only:false; response_revision:25896; number_of_response:1; }","duration":"290.124754ms","start":"2026-07-10T22:19:05.959146Z","end":"2026-07-10T22:19:06.249271Z","steps":["trace[1866487041] 'process raft request'  (duration: 290.082523ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:06.249406Z","caller":"traceutil/trace.go:171","msg":"trace[872452946] transaction","detail":"{read_only:false; response_revision:25895; number_of_response:1; }","duration":"290.956144ms","start":"2026-07-10T22:19:05.958421Z","end":"2026-07-10T22:19:06.249377Z","steps":["trace[872452946] 'process raft request'  (duration: 290.750108ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:06.249575Z","caller":"traceutil/trace.go:171","msg":"trace[1990310820] transaction","detail":"{read_only:false; response_revision:25897; number_of_response:1; }","duration":"224.180993ms","start":"2026-07-10T22:19:06.025365Z","end":"2026-07-10T22:19:06.249546Z","steps":["trace[1990310820] 'process raft request'  (duration: 223.882506ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:06.294688Z","caller":"traceutil/trace.go:171","msg":"trace[238590059] transaction","detail":"{read_only:false; response_revision:25898; number_of_response:1; }","duration":"157.584189ms","start":"2026-07-10T22:19:06.137086Z","end":"2026-07-10T22:19:06.294671Z","steps":["trace[238590059] 'process raft request'  (duration: 157.366933ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:06.29484Z","caller":"traceutil/trace.go:171","msg":"trace[45306320] transaction","detail":"{read_only:false; response_revision:25899; number_of_response:1; }","duration":"155.666811ms","start":"2026-07-10T22:19:06.139156Z","end":"2026-07-10T22:19:06.294823Z","steps":["trace[45306320] 'process raft request'  (duration: 155.477597ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:06.452228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.35031ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883508 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.77\" mod_revision:25798 > success:<request_put:<key:\"/registry/masterleases/199.204.45.77\" value_size:67 lease:6119441150744107693 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.77\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:06.452486Z","caller":"traceutil/trace.go:171","msg":"trace[1832077615] transaction","detail":"{read_only:false; response_revision:25900; number_of_response:1; }","duration":"202.236218ms","start":"2026-07-10T22:19:06.250216Z","end":"2026-07-10T22:19:06.452452Z","steps":["trace[1832077615] 'process raft request'  (duration: 101.58189ms)","trace[1832077615] 'compare'  (duration: 100.186886ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:06.90149Z","caller":"traceutil/trace.go:171","msg":"trace[1352756242] linearizableReadLoop","detail":"{readStateIndex:26748; appliedIndex:26747; }","duration":"269.731505ms","start":"2026-07-10T22:19:06.631737Z","end":"2026-07-10T22:19:06.901468Z","steps":["trace[1352756242] 'read index received'  (duration: 269.575041ms)","trace[1352756242] 'applied index is now lower than readState.Index'  (duration: 155.624µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:06.901819Z","caller":"traceutil/trace.go:171","msg":"trace[179542394] transaction","detail":"{read_only:false; response_revision:25902; number_of_response:1; }","duration":"304.508853ms","start":"2026-07-10T22:19:06.597298Z","end":"2026-07-10T22:19:06.901807Z","steps":["trace[179542394] 'process raft request'  (duration: 304.031342ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:06.901932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:06.597272Z","time spent":"304.582306ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25887 > 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-07-10T22:19:06.90219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.444373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:06.902238Z","caller":"traceutil/trace.go:171","msg":"trace[1755226888] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25902; }","duration":"270.520235ms","start":"2026-07-10T22:19:06.631702Z","end":"2026-07-10T22:19:06.902222Z","steps":["trace[1755226888] 'agreement among raft nodes before linearized reading'  (duration: 270.450704ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:07.969625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.057004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:07.969694Z","caller":"traceutil/trace.go:171","msg":"trace[1028958836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25904; }","duration":"177.173327ms","start":"2026-07-10T22:19:07.792505Z","end":"2026-07-10T22:19:07.969679Z","steps":["trace[1028958836] 'range keys from in-memory index tree'  (duration: 176.974271ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:08.246519Z","caller":"traceutil/trace.go:171","msg":"trace[1955155456] linearizableReadLoop","detail":"{readStateIndex:26753; appliedIndex:26752; }","duration":"190.366566ms","start":"2026-07-10T22:19:08.056128Z","end":"2026-07-10T22:19:08.246495Z","steps":["trace[1955155456] 'read index received'  (duration: 190.10959ms)","trace[1955155456] 'applied index is now lower than readState.Index'  (duration: 255.736µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:08.246633Z","caller":"traceutil/trace.go:171","msg":"trace[584006890] transaction","detail":"{read_only:false; response_revision:25907; number_of_response:1; }","duration":"263.112613ms","start":"2026-07-10T22:19:07.983441Z","end":"2026-07-10T22:19:08.246554Z","steps":["trace[584006890] 'process raft request'  (duration: 262.909498ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:08.246791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.445609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11789"}
{"level":"info","ts":"2026-07-10T22:19:08.246875Z","caller":"traceutil/trace.go:171","msg":"trace[2080760826] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25907; }","duration":"260.599382ms","start":"2026-07-10T22:19:07.986258Z","end":"2026-07-10T22:19:08.246857Z","steps":["trace[2080760826] 'agreement among raft nodes before linearized reading'  (duration: 260.348196ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:08.699363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.262261ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883537 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25898 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:08.699563Z","caller":"traceutil/trace.go:171","msg":"trace[1367214380] transaction","detail":"{read_only:false; response_revision:25912; number_of_response:1; }","duration":"400.657982ms","start":"2026-07-10T22:19:08.298877Z","end":"2026-07-10T22:19:08.699535Z","steps":["trace[1367214380] 'process raft request'  (duration: 279.102524ms)","trace[1367214380] 'compare'  (duration: 120.167415ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:08.699681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:08.298856Z","time spent":"400.785196ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25898 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-10T22:19:08.85331Z","caller":"traceutil/trace.go:171","msg":"trace[678384203] transaction","detail":"{read_only:false; response_revision:25913; number_of_response:1; }","duration":"554.184151ms","start":"2026-07-10T22:19:08.29905Z","end":"2026-07-10T22:19:08.853234Z","steps":["trace[678384203] 'process raft request'  (duration: 552.060469ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:08.853565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:08.298763Z","time spent":"554.642332ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25899 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-07-10T22:19:08.854783Z","caller":"traceutil/trace.go:171","msg":"trace[26355829] linearizableReadLoop","detail":"{readStateIndex:26760; appliedIndex:26758; }","duration":"176.366986ms","start":"2026-07-10T22:19:08.678394Z","end":"2026-07-10T22:19:08.854761Z","steps":["trace[26355829] 'read index received'  (duration: 172.771878ms)","trace[26355829] 'applied index is now lower than readState.Index'  (duration: 3.594308ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:08.854835Z","caller":"traceutil/trace.go:171","msg":"trace[1864979357] transaction","detail":"{read_only:false; response_revision:25914; number_of_response:1; }","duration":"395.185408ms","start":"2026-07-10T22:19:08.459615Z","end":"2026-07-10T22:19:08.8548Z","steps":["trace[1864979357] 'process raft request'  (duration: 395.027155ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:08.855026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:08.459594Z","time spent":"395.330032ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25901 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:08.856742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.50506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-10T22:19:08.856883Z","caller":"traceutil/trace.go:171","msg":"trace[1669530468] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25914; }","duration":"178.519118ms","start":"2026-07-10T22:19:08.678342Z","end":"2026-07-10T22:19:08.856861Z","steps":["trace[1669530468] 'agreement among raft nodes before linearized reading'  (duration: 176.51693ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:16.014813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.941011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:16.01493Z","caller":"traceutil/trace.go:171","msg":"trace[80408566] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:25974; }","duration":"164.138908ms","start":"2026-07-10T22:19:15.850766Z","end":"2026-07-10T22:19:16.014905Z","steps":["trace[80408566] 'count revisions from in-memory index tree'  (duration: 163.834229ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:16.015006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.868949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:16.01511Z","caller":"traceutil/trace.go:171","msg":"trace[1470082054] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25974; }","duration":"159.034743ms","start":"2026-07-10T22:19:15.856047Z","end":"2026-07-10T22:19:16.015082Z","steps":["trace[1470082054] 'count revisions from in-memory index tree'  (duration: 158.770437ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:16.217045Z","caller":"traceutil/trace.go:171","msg":"trace[1817546319] transaction","detail":"{read_only:false; response_revision:25976; number_of_response:1; }","duration":"133.052489ms","start":"2026-07-10T22:19:16.083941Z","end":"2026-07-10T22:19:16.216993Z","steps":["trace[1817546319] 'process raft request'  (duration: 131.311786ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:16.620587Z","caller":"traceutil/trace.go:171","msg":"trace[100018617] transaction","detail":"{read_only:false; response_revision:25979; number_of_response:1; }","duration":"285.810768ms","start":"2026-07-10T22:19:16.334749Z","end":"2026-07-10T22:19:16.62056Z","steps":["trace[100018617] 'process raft request'  (duration: 285.635744ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:16.66538Z","caller":"traceutil/trace.go:171","msg":"trace[1254704112] transaction","detail":"{read_only:false; response_revision:25980; number_of_response:1; }","duration":"328.043279ms","start":"2026-07-10T22:19:16.337303Z","end":"2026-07-10T22:19:16.665347Z","steps":["trace[1254704112] 'process raft request'  (duration: 300.011014ms)","trace[1254704112] 'compare'  (duration: 27.85063ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:16.665405Z","caller":"traceutil/trace.go:171","msg":"trace[237561566] transaction","detail":"{read_only:false; response_revision:25981; number_of_response:1; }","duration":"327.998108ms","start":"2026-07-10T22:19:16.337371Z","end":"2026-07-10T22:19:16.665369Z","steps":["trace[237561566] 'process raft request'  (duration: 327.890426ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:16.665539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:16.337281Z","time spent":"328.173332ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25963 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:16.665557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:16.337366Z","time spent":"328.108171ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25964 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:16.957749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.58653ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598883700 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25967 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:16.957944Z","caller":"traceutil/trace.go:171","msg":"trace[984938222] linearizableReadLoop","detail":"{readStateIndex:26830; appliedIndex:26829; }","duration":"163.800828ms","start":"2026-07-10T22:19:16.794119Z","end":"2026-07-10T22:19:16.95792Z","steps":["trace[984938222] 'read index received'  (duration: 18.85819ms)","trace[984938222] 'applied index is now lower than readState.Index'  (duration: 144.939758ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:16.958061Z","caller":"traceutil/trace.go:171","msg":"trace[477366458] transaction","detail":"{read_only:false; response_revision:25982; number_of_response:1; }","duration":"228.244712ms","start":"2026-07-10T22:19:16.729796Z","end":"2026-07-10T22:19:16.958041Z","steps":["trace[477366458] 'process raft request'  (duration: 83.247052ms)","trace[477366458] 'compare'  (duration: 144.459657ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:16.958221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.084406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:16.958353Z","caller":"traceutil/trace.go:171","msg":"trace[970581743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25983; }","duration":"164.27792ms","start":"2026-07-10T22:19:16.794048Z","end":"2026-07-10T22:19:16.958326Z","steps":["trace[970581743] 'agreement among raft nodes before linearized reading'  (duration: 164.087406ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:17.089836Z","caller":"traceutil/trace.go:171","msg":"trace[1117046502] linearizableReadLoop","detail":"{readStateIndex:26834; appliedIndex:26831; }","duration":"131.798118ms","start":"2026-07-10T22:19:16.958002Z","end":"2026-07-10T22:19:17.0898Z","steps":["trace[1117046502] 'read index received'  (duration: 130.984029ms)","trace[1117046502] 'applied index is now lower than readState.Index'  (duration: 812.529µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:17.090101Z","caller":"traceutil/trace.go:171","msg":"trace[1384074186] transaction","detail":"{read_only:false; response_revision:25985; number_of_response:1; }","duration":"177.421382ms","start":"2026-07-10T22:19:16.912648Z","end":"2026-07-10T22:19:17.09007Z","steps":["trace[1384074186] 'process raft request'  (duration: 177.034682ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:17.090315Z","caller":"traceutil/trace.go:171","msg":"trace[1734705763] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"155.506616ms","start":"2026-07-10T22:19:16.934635Z","end":"2026-07-10T22:19:17.090142Z","steps":["trace[1734705763] 'process raft request'  (duration: 155.098127ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:17.090403Z","caller":"traceutil/trace.go:171","msg":"trace[1160819255] transaction","detail":"{read_only:false; response_revision:25984; number_of_response:1; }","duration":"205.955028ms","start":"2026-07-10T22:19:16.884434Z","end":"2026-07-10T22:19:17.090389Z","steps":["trace[1160819255] 'process raft request'  (duration: 205.006576ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:17.090509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.721021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:17.090661Z","caller":"traceutil/trace.go:171","msg":"trace[270419339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25986; }","duration":"130.945318ms","start":"2026-07-10T22:19:16.959662Z","end":"2026-07-10T22:19:17.090607Z","steps":["trace[270419339] 'agreement among raft nodes before linearized reading'  (duration: 130.68243ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:17.090806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.111253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:17.09089Z","caller":"traceutil/trace.go:171","msg":"trace[621676057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:25986; }","duration":"240.303258ms","start":"2026-07-10T22:19:16.850553Z","end":"2026-07-10T22:19:17.090856Z","steps":["trace[621676057] 'agreement among raft nodes before linearized reading'  (duration: 240.168134ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:18.142374Z","caller":"traceutil/trace.go:171","msg":"trace[1945855169] transaction","detail":"{read_only:false; response_revision:25989; number_of_response:1; }","duration":"107.476133ms","start":"2026-07-10T22:19:18.03485Z","end":"2026-07-10T22:19:18.142326Z","steps":["trace[1945855169] 'process raft request'  (duration: 106.391347ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:18.781975Z","caller":"traceutil/trace.go:171","msg":"trace[1631525683] linearizableReadLoop","detail":"{readStateIndex:26838; appliedIndex:26837; }","duration":"495.339604ms","start":"2026-07-10T22:19:18.28661Z","end":"2026-07-10T22:19:18.78195Z","steps":["trace[1631525683] 'read index received'  (duration: 495.263782ms)","trace[1631525683] 'applied index is now lower than readState.Index'  (duration: 74.482µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:18.782023Z","caller":"traceutil/trace.go:171","msg":"trace[1853050662] transaction","detail":"{read_only:false; response_revision:25990; number_of_response:1; }","duration":"558.798243ms","start":"2026-07-10T22:19:18.2232Z","end":"2026-07-10T22:19:18.781998Z","steps":["trace[1853050662] 'process raft request'  (duration: 558.572278ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:18.78219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.223169Z","time spent":"558.914476ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25976 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:18.782195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.548759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-10T22:19:18.782286Z","caller":"traceutil/trace.go:171","msg":"trace[750285651] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:25990; }","duration":"495.660191ms","start":"2026-07-10T22:19:18.286602Z","end":"2026-07-10T22:19:18.782262Z","steps":["trace[750285651] 'agreement among raft nodes before linearized reading'  (duration: 495.474017ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:18.78235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.28653Z","time spent":"495.807645ms","remote":"127.0.0.1:41326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "}
{"level":"info","ts":"2026-07-10T22:19:18.98042Z","caller":"traceutil/trace.go:171","msg":"trace[900571059] linearizableReadLoop","detail":"{readStateIndex:26839; appliedIndex:26838; }","duration":"198.348003ms","start":"2026-07-10T22:19:18.782042Z","end":"2026-07-10T22:19:18.98039Z","steps":["trace[900571059] 'read index received'  (duration: 145.628885ms)","trace[900571059] 'applied index is now lower than readState.Index'  (duration: 52.717898ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:18.980616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.690396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-07-10T22:19:18.98063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.578223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-07-10T22:19:18.980685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.863122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-07-10T22:19:18.980685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.548971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-10T22:19:18.980705Z","caller":"traceutil/trace.go:171","msg":"trace[1839358339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25991; }","duration":"310.734677ms","start":"2026-07-10T22:19:18.669952Z","end":"2026-07-10T22:19:18.980687Z","steps":["trace[1839358339] 'agreement among raft nodes before linearized reading'  (duration: 310.45363ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:18.980724Z","caller":"traceutil/trace.go:171","msg":"trace[138230849] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25991; }","duration":"642.011415ms","start":"2026-07-10T22:19:18.338702Z","end":"2026-07-10T22:19:18.980713Z","steps":["trace[138230849] 'agreement among raft nodes before linearized reading'  (duration: 641.80886ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:18.980755Z","caller":"traceutil/trace.go:171","msg":"trace[1612046203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25991; }","duration":"355.671663ms","start":"2026-07-10T22:19:18.625067Z","end":"2026-07-10T22:19:18.980739Z","steps":["trace[1612046203] 'agreement among raft nodes before linearized reading'  (duration: 355.441998ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:18.980764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.66992Z","time spent":"310.834399ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-10T22:19:18.9807Z","caller":"traceutil/trace.go:171","msg":"trace[1754529317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25991; }","duration":"310.801118ms","start":"2026-07-10T22:19:18.669873Z","end":"2026-07-10T22:19:18.980674Z","steps":["trace[1754529317] 'agreement among raft nodes before linearized reading'  (duration: 310.564802ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:18.980816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.625048Z","time spent":"355.745856ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-07-10T22:19:18.980604Z","caller":"traceutil/trace.go:171","msg":"trace[336463634] transaction","detail":"{read_only:false; response_revision:25991; number_of_response:1; }","duration":"641.585135ms","start":"2026-07-10T22:19:18.338893Z","end":"2026-07-10T22:19:18.980478Z","steps":["trace[336463634] 'process raft request'  (duration: 588.794066ms)","trace[336463634] 'compare'  (duration: 52.536523ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:18.980761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.338686Z","time spent":"642.067477ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-10T22:19:18.980879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.669862Z","time spent":"310.977443ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-10T22:19:18.980964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:18.338871Z","time spent":"642.025115ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25978 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:18.98228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.501087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:18.982516Z","caller":"traceutil/trace.go:171","msg":"trace[1104846489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25993; }","duration":"191.777853ms","start":"2026-07-10T22:19:18.790724Z","end":"2026-07-10T22:19:18.982502Z","steps":["trace[1104846489] 'agreement among raft nodes before linearized reading'  (duration: 191.461345ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:21.009537Z","caller":"traceutil/trace.go:171","msg":"trace[1462888102] linearizableReadLoop","detail":"{readStateIndex:26857; appliedIndex:26856; }","duration":"218.188556ms","start":"2026-07-10T22:19:20.791324Z","end":"2026-07-10T22:19:21.009513Z","steps":["trace[1462888102] 'read index received'  (duration: 218.051193ms)","trace[1462888102] 'applied index is now lower than readState.Index'  (duration: 136.413µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:21.009667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.334539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:21.00971Z","caller":"traceutil/trace.go:171","msg":"trace[284012661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26009; }","duration":"218.425083ms","start":"2026-07-10T22:19:20.79127Z","end":"2026-07-10T22:19:21.009695Z","steps":["trace[284012661] 'agreement among raft nodes before linearized reading'  (duration: 218.33838ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:21.009565Z","caller":"traceutil/trace.go:171","msg":"trace[1624105134] transaction","detail":"{read_only:false; response_revision:26009; number_of_response:1; }","duration":"220.665547ms","start":"2026-07-10T22:19:20.788868Z","end":"2026-07-10T22:19:21.009534Z","steps":["trace[1624105134] 'process raft request'  (duration: 220.497553ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:21.012685Z","caller":"traceutil/trace.go:171","msg":"trace[30582513] transaction","detail":"{read_only:false; response_revision:26010; number_of_response:1; }","duration":"214.956779ms","start":"2026-07-10T22:19:20.797692Z","end":"2026-07-10T22:19:21.012649Z","steps":["trace[30582513] 'process raft request'  (duration: 214.715282ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:27.516032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.38276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-07-10T22:19:27.51612Z","caller":"traceutil/trace.go:171","msg":"trace[966597854] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148; range_end:; response_count:1; response_revision:26130; }","duration":"238.507704ms","start":"2026-07-10T22:19:27.277594Z","end":"2026-07-10T22:19:27.516102Z","steps":["trace[966597854] 'range keys from in-memory index tree'  (duration: 238.177066ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:28.057029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.540781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-07-10T22:19:28.057119Z","caller":"traceutil/trace.go:171","msg":"trace[184927045] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148; range_end:; response_count:1; response_revision:26131; }","duration":"133.674444ms","start":"2026-07-10T22:19:27.923428Z","end":"2026-07-10T22:19:28.057102Z","steps":["trace[184927045] 'range keys from in-memory index tree'  (duration: 133.403417ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:28.482867Z","caller":"traceutil/trace.go:171","msg":"trace[599898182] transaction","detail":"{read_only:false; response_revision:26132; number_of_response:1; }","duration":"418.063967ms","start":"2026-07-10T22:19:28.064777Z","end":"2026-07-10T22:19:28.482841Z","steps":["trace[599898182] 'process raft request'  (duration: 417.922024ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:28.483014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:28.064748Z","time spent":"418.19008ms","remote":"127.0.0.1:54224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148\" mod_revision:26108 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148\" value_size:3645 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b59d461d-1df3-4fa7-9ec3-21d0a6e6d148\" > >"}
{"level":"info","ts":"2026-07-10T22:19:28.516845Z","caller":"traceutil/trace.go:171","msg":"trace[1455549454] linearizableReadLoop","detail":"{readStateIndex:26983; appliedIndex:26981; }","duration":"325.101937ms","start":"2026-07-10T22:19:28.191706Z","end":"2026-07-10T22:19:28.516808Z","steps":["trace[1455549454] 'read index received'  (duration: 291.010595ms)","trace[1455549454] 'applied index is now lower than readState.Index'  (duration: 34.089952ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:28.516936Z","caller":"traceutil/trace.go:171","msg":"trace[1262422539] transaction","detail":"{read_only:false; response_revision:26133; number_of_response:1; }","duration":"347.243658ms","start":"2026-07-10T22:19:28.16966Z","end":"2026-07-10T22:19:28.516904Z","steps":["trace[1262422539] 'process raft request'  (duration: 346.961251ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:28.517074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:28.16963Z","time spent":"347.366261ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26086 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:28.517164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.435296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"warn","ts":"2026-07-10T22:19:28.517222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.339557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"}
{"level":"info","ts":"2026-07-10T22:19:28.517315Z","caller":"traceutil/trace.go:171","msg":"trace[180055144] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26133; }","duration":"267.501901ms","start":"2026-07-10T22:19:28.249787Z","end":"2026-07-10T22:19:28.517289Z","steps":["trace[180055144] 'agreement among raft nodes before linearized reading'  (duration: 267.220404ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:28.517547Z","caller":"traceutil/trace.go:171","msg":"trace[951860335] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:26133; }","duration":"325.579428ms","start":"2026-07-10T22:19:28.191663Z","end":"2026-07-10T22:19:28.517243Z","steps":["trace[951860335] 'agreement among raft nodes before linearized reading'  (duration: 325.300162ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:28.517599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:28.191646Z","time spent":"325.941009ms","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" "}
{"level":"info","ts":"2026-07-10T22:19:28.656872Z","caller":"traceutil/trace.go:171","msg":"trace[1628493743] linearizableReadLoop","detail":"{readStateIndex:26984; appliedIndex:26983; }","duration":"120.776639ms","start":"2026-07-10T22:19:28.53607Z","end":"2026-07-10T22:19:28.656846Z","steps":["trace[1628493743] 'read index received'  (duration: 108.714195ms)","trace[1628493743] 'applied index is now lower than readState.Index'  (duration: 12.061384ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:28.656926Z","caller":"traceutil/trace.go:171","msg":"trace[2047521902] transaction","detail":"{read_only:false; response_revision:26134; number_of_response:1; }","duration":"122.924731ms","start":"2026-07-10T22:19:28.533964Z","end":"2026-07-10T22:19:28.656889Z","steps":["trace[2047521902] 'process raft request'  (duration: 110.838396ms)","trace[2047521902] 'compare'  (duration: 11.818079ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:28.657092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.009674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"}
{"level":"info","ts":"2026-07-10T22:19:28.657176Z","caller":"traceutil/trace.go:171","msg":"trace[864788205] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26134; }","duration":"121.131728ms","start":"2026-07-10T22:19:28.53602Z","end":"2026-07-10T22:19:28.657151Z","steps":["trace[864788205] 'agreement among raft nodes before linearized reading'  (duration: 120.908892ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:28.804541Z","caller":"traceutil/trace.go:171","msg":"trace[1641967304] linearizableReadLoop","detail":"{readStateIndex:26985; appliedIndex:26984; }","duration":"133.205982ms","start":"2026-07-10T22:19:28.671294Z","end":"2026-07-10T22:19:28.8045Z","steps":["trace[1641967304] 'read index received'  (duration: 131.312766ms)","trace[1641967304] 'applied index is now lower than readState.Index'  (duration: 1.891426ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:28.804562Z","caller":"traceutil/trace.go:171","msg":"trace[652978014] transaction","detail":"{read_only:false; response_revision:26135; number_of_response:1; }","duration":"140.636614ms","start":"2026-07-10T22:19:28.663875Z","end":"2026-07-10T22:19:28.804511Z","steps":["trace[652978014] 'process raft request'  (duration: 138.753877ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:28.804742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.425938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"}
{"level":"info","ts":"2026-07-10T22:19:28.804818Z","caller":"traceutil/trace.go:171","msg":"trace[1954399543] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26135; }","duration":"133.52598ms","start":"2026-07-10T22:19:28.671271Z","end":"2026-07-10T22:19:28.804797Z","steps":["trace[1954399543] 'agreement among raft nodes before linearized reading'  (duration: 133.313375ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:34.878431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.710142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-10T22:19:34.878507Z","caller":"traceutil/trace.go:171","msg":"trace[1897288484] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26213; }","duration":"223.822925ms","start":"2026-07-10T22:19:34.654667Z","end":"2026-07-10T22:19:34.87849Z","steps":["trace[1897288484] 'range keys from in-memory index tree'  (duration: 223.540958ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.296944Z","caller":"traceutil/trace.go:171","msg":"trace[1747662851] linearizableReadLoop","detail":"{readStateIndex:27068; appliedIndex:27064; }","duration":"219.224673ms","start":"2026-07-10T22:19:35.077701Z","end":"2026-07-10T22:19:35.296925Z","steps":["trace[1747662851] 'read index received'  (duration: 72.702785ms)","trace[1747662851] 'applied index is now lower than readState.Index'  (duration: 146.520958ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:35.296984Z","caller":"traceutil/trace.go:171","msg":"trace[455133544] transaction","detail":"{read_only:false; response_revision:26215; number_of_response:1; }","duration":"237.011038ms","start":"2026-07-10T22:19:35.059946Z","end":"2026-07-10T22:19:35.296957Z","steps":["trace[455133544] 'process raft request'  (duration: 236.761222ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.297043Z","caller":"traceutil/trace.go:171","msg":"trace[1219400874] transaction","detail":"{read_only:false; response_revision:26216; number_of_response:1; }","duration":"235.646443ms","start":"2026-07-10T22:19:35.061389Z","end":"2026-07-10T22:19:35.297035Z","steps":["trace[1219400874] 'process raft request'  (duration: 235.479519ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.297155Z","caller":"traceutil/trace.go:171","msg":"trace[1444105854] transaction","detail":"{read_only:false; response_revision:26217; number_of_response:1; }","duration":"227.442943ms","start":"2026-07-10T22:19:35.069707Z","end":"2026-07-10T22:19:35.29715Z","steps":["trace[1444105854] 'process raft request'  (duration: 227.191937ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.297316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.603533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-10T22:19:35.297344Z","caller":"traceutil/trace.go:171","msg":"trace[1918074576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26217; }","duration":"219.683275ms","start":"2026-07-10T22:19:35.077655Z","end":"2026-07-10T22:19:35.297338Z","steps":["trace[1918074576] 'agreement among raft nodes before linearized reading'  (duration: 219.548631ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.530197Z","caller":"traceutil/trace.go:171","msg":"trace[2120503823] linearizableReadLoop","detail":"{readStateIndex:27071; appliedIndex:27068; }","duration":"233.159592ms","start":"2026-07-10T22:19:35.297008Z","end":"2026-07-10T22:19:35.530168Z","steps":["trace[2120503823] 'read index received'  (duration: 229.077032ms)","trace[2120503823] 'applied index is now lower than readState.Index'  (duration: 4.08119ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:35.53029Z","caller":"traceutil/trace.go:171","msg":"trace[1639981924] transaction","detail":"{read_only:false; response_revision:26219; number_of_response:1; }","duration":"363.757702ms","start":"2026-07-10T22:19:35.166508Z","end":"2026-07-10T22:19:35.530266Z","steps":["trace[1639981924] 'process raft request'  (duration: 363.524876ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.530298Z","caller":"traceutil/trace.go:171","msg":"trace[1175961507] transaction","detail":"{read_only:false; response_revision:26220; number_of_response:1; }","duration":"330.09375ms","start":"2026-07-10T22:19:35.200177Z","end":"2026-07-10T22:19:35.530271Z","steps":["trace[1175961507] 'process raft request'  (duration: 329.935266ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.530418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.166501Z","time spent":"363.843614ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26203 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:35.53043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.158356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/magnum-cluster-api-proxy-crfch.18c10da77364f22d\" ","response":"range_response_count:1 size:896"}
{"level":"warn","ts":"2026-07-10T22:19:35.530433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.200157Z","time spent":"330.200432ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26204 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-10T22:19:35.530474Z","caller":"traceutil/trace.go:171","msg":"trace[1723347731] range","detail":"{range_begin:/registry/events/openstack/magnum-cluster-api-proxy-crfch.18c10da77364f22d; range_end:; response_count:1; response_revision:26220; }","duration":"356.251647ms","start":"2026-07-10T22:19:35.17421Z","end":"2026-07-10T22:19:35.530461Z","steps":["trace[1723347731] 'agreement among raft nodes before linearized reading'  (duration: 356.045142ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.53045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.418995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-07-10T22:19:35.5305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.17419Z","time spent":"356.304539ms","remote":"127.0.0.1:54130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":919,"request content":"key:\"/registry/events/openstack/magnum-cluster-api-proxy-crfch.18c10da77364f22d\" "}
{"level":"warn","ts":"2026-07-10T22:19:35.530487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.252865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-07-10T22:19:35.530515Z","caller":"traceutil/trace.go:171","msg":"trace[662790236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26220; }","duration":"443.513008ms","start":"2026-07-10T22:19:35.086986Z","end":"2026-07-10T22:19:35.530499Z","steps":["trace[662790236] 'agreement among raft nodes before linearized reading'  (duration: 443.282883ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.530545Z","caller":"traceutil/trace.go:171","msg":"trace[1206073512] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26220; }","duration":"446.342567ms","start":"2026-07-10T22:19:35.084184Z","end":"2026-07-10T22:19:35.530527Z","steps":["trace[1206073512] 'agreement among raft nodes before linearized reading'  (duration: 446.131282ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.530555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.366787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-07-10T22:19:35.530559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.086976Z","time spent":"443.572799ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-07-10T22:19:35.530635Z","caller":"traceutil/trace.go:171","msg":"trace[591605591] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26220; }","duration":"448.50114ms","start":"2026-07-10T22:19:35.082117Z","end":"2026-07-10T22:19:35.530619Z","steps":["trace[591605591] 'agreement among raft nodes before linearized reading'  (duration: 448.253124ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.530645Z","caller":"traceutil/trace.go:171","msg":"trace[899423994] transaction","detail":"{read_only:false; response_revision:26218; number_of_response:1; }","duration":"365.580875ms","start":"2026-07-10T22:19:35.165053Z","end":"2026-07-10T22:19:35.530634Z","steps":["trace[899423994] 'process raft request'  (duration: 361.019434ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.53067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.082097Z","time spent":"448.565992ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-07-10T22:19:35.530686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.16503Z","time spent":"365.634897ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26202 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:35.53069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.718142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-10T22:19:35.530554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.189216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-10T22:19:35.53073Z","caller":"traceutil/trace.go:171","msg":"trace[316490441] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:26220; }","duration":"395.801863ms","start":"2026-07-10T22:19:35.134915Z","end":"2026-07-10T22:19:35.530717Z","steps":["trace[316490441] 'agreement among raft nodes before linearized reading'  (duration: 395.738762ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.530737Z","caller":"traceutil/trace.go:171","msg":"trace[549999007] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:26220; }","duration":"254.412832ms","start":"2026-07-10T22:19:35.276312Z","end":"2026-07-10T22:19:35.530725Z","steps":["trace[549999007] 'agreement among raft nodes before linearized reading'  (duration: 254.089124ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.530768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.134892Z","time spent":"395.867155ms","remote":"127.0.0.1:54406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"warn","ts":"2026-07-10T22:19:35.530753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.268948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-cluster-api-proxy-crfch\" ","response":"range_response_count:1 size:5279"}
{"level":"warn","ts":"2026-07-10T22:19:35.530782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.073864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-10T22:19:35.530832Z","caller":"traceutil/trace.go:171","msg":"trace[1495453693] range","detail":"{range_begin:/registry/pods/openstack/magnum-cluster-api-proxy-crfch; range_end:; response_count:1; response_revision:26220; }","duration":"358.38072ms","start":"2026-07-10T22:19:35.172432Z","end":"2026-07-10T22:19:35.530813Z","steps":["trace[1495453693] 'agreement among raft nodes before linearized reading'  (duration: 358.092883ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:35.530855Z","caller":"traceutil/trace.go:171","msg":"trace[960751396] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26220; }","duration":"449.189747ms","start":"2026-07-10T22:19:35.081641Z","end":"2026-07-10T22:19:35.530831Z","steps":["trace[960751396] 'agreement among raft nodes before linearized reading'  (duration: 449.018423ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:35.53063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.084174Z","time spent":"446.44338ms","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1883,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"warn","ts":"2026-07-10T22:19:35.530876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.172424Z","time spent":"358.442711ms","remote":"127.0.0.1:54224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":5302,"request content":"key:\"/registry/pods/openstack/magnum-cluster-api-proxy-crfch\" "}
{"level":"warn","ts":"2026-07-10T22:19:35.530891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:35.081623Z","time spent":"449.259618ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-07-10T22:19:35.532131Z","caller":"traceutil/trace.go:171","msg":"trace[2107972036] transaction","detail":"{read_only:false; response_revision:26221; number_of_response:1; }","duration":"230.642472ms","start":"2026-07-10T22:19:35.301472Z","end":"2026-07-10T22:19:35.532115Z","steps":["trace[2107972036] 'process raft request'  (duration: 230.482847ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:39.973956Z","caller":"traceutil/trace.go:171","msg":"trace[505781821] transaction","detail":"{read_only:false; response_revision:26261; number_of_response:1; }","duration":"118.161355ms","start":"2026-07-10T22:19:39.855753Z","end":"2026-07-10T22:19:39.973914Z","steps":["trace[505781821] 'process raft request'  (duration: 117.677733ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:49.682049Z","caller":"traceutil/trace.go:171","msg":"trace[958297935] transaction","detail":"{read_only:false; response_revision:26344; number_of_response:1; }","duration":"100.35616ms","start":"2026-07-10T22:19:49.581663Z","end":"2026-07-10T22:19:49.682019Z","steps":["trace[958297935] 'process raft request'  (duration: 100.046242ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:49.894984Z","caller":"traceutil/trace.go:171","msg":"trace[1524475015] transaction","detail":"{read_only:false; response_revision:26345; number_of_response:1; }","duration":"312.635914ms","start":"2026-07-10T22:19:49.582174Z","end":"2026-07-10T22:19:49.89481Z","steps":["trace[1524475015] 'process raft request'  (duration: 312.280094ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:49.8953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:49.582161Z","time spent":"312.985552ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26329 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-10T22:19:49.895293Z","caller":"traceutil/trace.go:171","msg":"trace[1401990393] linearizableReadLoop","detail":"{readStateIndex:27201; appliedIndex:27198; }","duration":"298.924849ms","start":"2026-07-10T22:19:49.596332Z","end":"2026-07-10T22:19:49.895256Z","steps":["trace[1401990393] 'read index received'  (duration: 85.508348ms)","trace[1401990393] 'applied index is now lower than readState.Index'  (duration: 213.41402ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:49.895468Z","caller":"traceutil/trace.go:171","msg":"trace[1336612225] transaction","detail":"{read_only:false; response_revision:26346; number_of_response:1; }","duration":"309.304713ms","start":"2026-07-10T22:19:49.586118Z","end":"2026-07-10T22:19:49.895422Z","steps":["trace[1336612225] 'process raft request'  (duration: 308.618006ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:49.895595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.248517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-07-10T22:19:49.895637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:49.586092Z","time spent":"309.447085ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26330 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-10T22:19:49.895663Z","caller":"traceutil/trace.go:171","msg":"trace[1865774946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26346; }","duration":"299.38389ms","start":"2026-07-10T22:19:49.596261Z","end":"2026-07-10T22:19:49.895645Z","steps":["trace[1865774946] 'agreement among raft nodes before linearized reading'  (duration: 299.164775ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:49.895644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.157125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-10T22:19:49.89574Z","caller":"traceutil/trace.go:171","msg":"trace[1709644346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26346; }","duration":"297.275898ms","start":"2026-07-10T22:19:49.598444Z","end":"2026-07-10T22:19:49.89572Z","steps":["trace[1709644346] 'agreement among raft nodes before linearized reading'  (duration: 297.035032ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:49.895747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.129028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-10T22:19:49.895674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.51092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-10T22:19:49.895811Z","caller":"traceutil/trace.go:171","msg":"trace[1568575317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26346; }","duration":"103.2257ms","start":"2026-07-10T22:19:49.792568Z","end":"2026-07-10T22:19:49.895794Z","steps":["trace[1568575317] 'agreement among raft nodes before linearized reading'  (duration: 103.145839ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:49.895821Z","caller":"traceutil/trace.go:171","msg":"trace[123980055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26346; }","duration":"287.677394ms","start":"2026-07-10T22:19:49.60813Z","end":"2026-07-10T22:19:49.895807Z","steps":["trace[123980055] 'agreement among raft nodes before linearized reading'  (duration: 287.430258ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:49.895907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.171373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-10T22:19:49.895953Z","caller":"traceutil/trace.go:171","msg":"trace[1693437135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26346; }","duration":"292.277486ms","start":"2026-07-10T22:19:49.603664Z","end":"2026-07-10T22:19:49.895941Z","steps":["trace[1693437135] 'agreement among raft nodes before linearized reading'  (duration: 292.095102ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.083026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.055178ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884533 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26333 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:50.083246Z","caller":"traceutil/trace.go:171","msg":"trace[528158690] transaction","detail":"{read_only:false; response_revision:26347; number_of_response:1; }","duration":"182.549536ms","start":"2026-07-10T22:19:49.90067Z","end":"2026-07-10T22:19:50.08322Z","steps":["trace[528158690] 'process raft request'  (duration: 74.206061ms)","trace[528158690] 'compare'  (duration: 107.875804ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:50.083321Z","caller":"traceutil/trace.go:171","msg":"trace[294738214] linearizableReadLoop","detail":"{readStateIndex:27205; appliedIndex:27201; }","duration":"150.216337ms","start":"2026-07-10T22:19:49.933092Z","end":"2026-07-10T22:19:50.083308Z","steps":["trace[294738214] 'read index received'  (duration: 41.831891ms)","trace[294738214] 'applied index is now lower than readState.Index'  (duration: 108.383206ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:50.083353Z","caller":"traceutil/trace.go:171","msg":"trace[905883870] transaction","detail":"{read_only:false; response_revision:26348; number_of_response:1; }","duration":"182.616899ms","start":"2026-07-10T22:19:49.900703Z","end":"2026-07-10T22:19:50.08332Z","steps":["trace[905883870] 'process raft request'  (duration: 182.425494ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:50.083458Z","caller":"traceutil/trace.go:171","msg":"trace[634092260] transaction","detail":"{read_only:false; response_revision:26349; number_of_response:1; }","duration":"182.629898ms","start":"2026-07-10T22:19:49.900803Z","end":"2026-07-10T22:19:50.083433Z","steps":["trace[634092260] 'process raft request'  (duration: 182.423493ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:50.083457Z","caller":"traceutil/trace.go:171","msg":"trace[672239562] transaction","detail":"{read_only:false; response_revision:26350; number_of_response:1; }","duration":"181.979763ms","start":"2026-07-10T22:19:49.901436Z","end":"2026-07-10T22:19:50.083416Z","steps":["trace[672239562] 'process raft request'  (duration: 181.83329ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.083509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.406883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-10T22:19:50.083557Z","caller":"traceutil/trace.go:171","msg":"trace[315338400] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:26350; }","duration":"150.493014ms","start":"2026-07-10T22:19:49.933052Z","end":"2026-07-10T22:19:50.083545Z","steps":["trace[315338400] 'agreement among raft nodes before linearized reading'  (duration: 150.382251ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.453142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.530232ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884539 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26335 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:50.453458Z","caller":"traceutil/trace.go:171","msg":"trace[448818462] transaction","detail":"{read_only:false; response_revision:26351; number_of_response:1; }","duration":"365.127165ms","start":"2026-07-10T22:19:50.088284Z","end":"2026-07-10T22:19:50.453411Z","steps":["trace[448818462] 'process raft request'  (duration: 131.249694ms)","trace[448818462] 'compare'  (duration: 233.234795ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:50.45353Z","caller":"traceutil/trace.go:171","msg":"trace[2015868639] linearizableReadLoop","detail":"{readStateIndex:27207; appliedIndex:27205; }","duration":"318.783293ms","start":"2026-07-10T22:19:50.13473Z","end":"2026-07-10T22:19:50.453513Z","steps":["trace[2015868639] 'read index received'  (duration: 84.81375ms)","trace[2015868639] 'applied index is now lower than readState.Index'  (duration: 233.968563ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:50.453543Z","caller":"traceutil/trace.go:171","msg":"trace[686571476] transaction","detail":"{read_only:false; response_revision:26352; number_of_response:1; }","duration":"340.669328ms","start":"2026-07-10T22:19:50.112859Z","end":"2026-07-10T22:19:50.453529Z","steps":["trace[686571476] 'process raft request'  (duration: 340.382421ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.453608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:50.112835Z","time spent":"340.74091ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:26261 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:50.45366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:50.088256Z","time spent":"365.297748ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26335 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-07-10T22:19:50.453747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.991749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-10T22:19:50.453834Z","caller":"traceutil/trace.go:171","msg":"trace[342027855] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26352; }","duration":"319.140722ms","start":"2026-07-10T22:19:50.134673Z","end":"2026-07-10T22:19:50.453814Z","steps":["trace[342027855] 'agreement among raft nodes before linearized reading'  (duration: 318.914837ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.453888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:19:50.134649Z","time spent":"319.227444ms","remote":"127.0.0.1:37184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-07-10T22:19:50.453907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.061731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-07-10T22:19:50.454058Z","caller":"traceutil/trace.go:171","msg":"trace[1335853152] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26352; }","duration":"258.254196ms","start":"2026-07-10T22:19:50.195783Z","end":"2026-07-10T22:19:50.454037Z","steps":["trace[1335853152] 'agreement among raft nodes before linearized reading'  (duration: 257.952079ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.780577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.350364ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884550 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:26306 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:50.780759Z","caller":"traceutil/trace.go:171","msg":"trace[1608912326] transaction","detail":"{read_only:false; response_revision:26353; number_of_response:1; }","duration":"229.565075ms","start":"2026-07-10T22:19:50.551096Z","end":"2026-07-10T22:19:50.780661Z","steps":["trace[1608912326] 'process raft request'  (duration: 101.049987ms)","trace[1608912326] 'compare'  (duration: 128.233181ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:50.7912Z","caller":"traceutil/trace.go:171","msg":"trace[750303277] transaction","detail":"{read_only:false; response_revision:26354; number_of_response:1; }","duration":"142.253494ms","start":"2026-07-10T22:19:50.648927Z","end":"2026-07-10T22:19:50.79118Z","steps":["trace[750303277] 'process raft request'  (duration: 142.13229ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:50.949116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.958521ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884552 > lease_revoke:<id:54ec9f4dee029d9e>","response":"size:29"}
{"level":"warn","ts":"2026-07-10T22:19:51.518813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.729317ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884558 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26341 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:51.519094Z","caller":"traceutil/trace.go:171","msg":"trace[531138830] transaction","detail":"{read_only:false; response_revision:26356; number_of_response:1; }","duration":"172.364458ms","start":"2026-07-10T22:19:51.3467Z","end":"2026-07-10T22:19:51.519064Z","steps":["trace[531138830] 'process raft request'  (duration: 40.269343ms)","trace[531138830] 'compare'  (duration: 131.47771ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:51.519229Z","caller":"traceutil/trace.go:171","msg":"trace[600718435] transaction","detail":"{read_only:false; response_revision:26357; number_of_response:1; }","duration":"158.692434ms","start":"2026-07-10T22:19:51.360515Z","end":"2026-07-10T22:19:51.519207Z","steps":["trace[600718435] 'process raft request'  (duration: 158.422887ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:51.519285Z","caller":"traceutil/trace.go:171","msg":"trace[2019485812] transaction","detail":"{read_only:false; response_revision:26358; number_of_response:1; }","duration":"155.844514ms","start":"2026-07-10T22:19:51.363401Z","end":"2026-07-10T22:19:51.519245Z","steps":["trace[2019485812] 'process raft request'  (duration: 155.630939ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:51.519155Z","caller":"traceutil/trace.go:171","msg":"trace[424299674] transaction","detail":"{read_only:false; response_revision:26359; number_of_response:1; }","duration":"147.07574ms","start":"2026-07-10T22:19:51.372064Z","end":"2026-07-10T22:19:51.51914Z","steps":["trace[424299674] 'process raft request'  (duration: 147.021429ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:58.312826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.54566ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884721 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26406 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:58.313128Z","caller":"traceutil/trace.go:171","msg":"trace[29558338] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"193.891415ms","start":"2026-07-10T22:19:58.119214Z","end":"2026-07-10T22:19:58.313105Z","steps":["trace[29558338] 'process raft request'  (duration: 59.79369ms)","trace[29558338] 'compare'  (duration: 133.396687ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:58.313532Z","caller":"traceutil/trace.go:171","msg":"trace[966248591] linearizableReadLoop","detail":"{readStateIndex:27284; appliedIndex:27282; }","duration":"185.817358ms","start":"2026-07-10T22:19:58.127704Z","end":"2026-07-10T22:19:58.313521Z","steps":["trace[966248591] 'read index received'  (duration: 4.923041ms)","trace[966248591] 'applied index is now lower than readState.Index'  (duration: 180.893527ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:58.313679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.978821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-07-10T22:19:58.313728Z","caller":"traceutil/trace.go:171","msg":"trace[1308726993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26427; }","duration":"186.047033ms","start":"2026-07-10T22:19:58.127658Z","end":"2026-07-10T22:19:58.313705Z","steps":["trace[1308726993] 'agreement among raft nodes before linearized reading'  (duration: 185.91152ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:58.313728Z","caller":"traceutil/trace.go:171","msg":"trace[110634185] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"192.212163ms","start":"2026-07-10T22:19:58.121492Z","end":"2026-07-10T22:19:58.313704Z","steps":["trace[110634185] 'process raft request'  (duration: 191.564847ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:58.576697Z","caller":"traceutil/trace.go:171","msg":"trace[106610488] transaction","detail":"{read_only:false; response_revision:26428; number_of_response:1; }","duration":"259.28212ms","start":"2026-07-10T22:19:58.317384Z","end":"2026-07-10T22:19:58.576666Z","steps":["trace[106610488] 'process raft request'  (duration: 180.426895ms)","trace[106610488] 'compare'  (duration: 77.897751ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:58.852979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.994877ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884726 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26412 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:19:58.853081Z","caller":"traceutil/trace.go:171","msg":"trace[98844428] linearizableReadLoop","detail":"{readStateIndex:27286; appliedIndex:27285; }","duration":"214.972978ms","start":"2026-07-10T22:19:58.638093Z","end":"2026-07-10T22:19:58.853066Z","steps":["trace[98844428] 'read index received'  (duration: 38.751516ms)","trace[98844428] 'applied index is now lower than readState.Index'  (duration: 176.219972ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:58.853109Z","caller":"traceutil/trace.go:171","msg":"trace[1646683996] transaction","detail":"{read_only:false; response_revision:26429; number_of_response:1; }","duration":"273.156188ms","start":"2026-07-10T22:19:58.579916Z","end":"2026-07-10T22:19:58.853072Z","steps":["trace[1646683996] 'process raft request'  (duration: 96.986607ms)","trace[1646683996] 'compare'  (duration: 175.434134ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:19:58.853299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.184873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:58.853364Z","caller":"traceutil/trace.go:171","msg":"trace[219687584] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:26429; }","duration":"215.316716ms","start":"2026-07-10T22:19:58.638032Z","end":"2026-07-10T22:19:58.853349Z","steps":["trace[219687584] 'agreement among raft nodes before linearized reading'  (duration: 215.209213ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:59.00686Z","caller":"traceutil/trace.go:171","msg":"trace[1282948835] linearizableReadLoop","detail":"{readStateIndex:27287; appliedIndex:27286; }","duration":"153.597441ms","start":"2026-07-10T22:19:58.853238Z","end":"2026-07-10T22:19:59.006835Z","steps":["trace[1282948835] 'read index received'  (duration: 153.428837ms)","trace[1282948835] 'applied index is now lower than readState.Index'  (duration: 167.134µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:59.006901Z","caller":"traceutil/trace.go:171","msg":"trace[86123268] transaction","detail":"{read_only:false; response_revision:26430; number_of_response:1; }","duration":"190.805019ms","start":"2026-07-10T22:19:58.816069Z","end":"2026-07-10T22:19:59.006874Z","steps":["trace[86123268] 'process raft request'  (duration: 190.611564ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:59.007021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.814293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:59.007091Z","caller":"traceutil/trace.go:171","msg":"trace[918366979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26430; }","duration":"216.933276ms","start":"2026-07-10T22:19:58.790142Z","end":"2026-07-10T22:19:59.007075Z","steps":["trace[918366979] 'agreement among raft nodes before linearized reading'  (duration: 216.797813ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:59.007105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.838301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3308"}
{"level":"info","ts":"2026-07-10T22:19:59.007147Z","caller":"traceutil/trace.go:171","msg":"trace[1494642499] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26430; }","duration":"143.932114ms","start":"2026-07-10T22:19:58.863199Z","end":"2026-07-10T22:19:59.007131Z","steps":["trace[1494642499] 'agreement among raft nodes before linearized reading'  (duration: 143.77603ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:19:59.486097Z","caller":"traceutil/trace.go:171","msg":"trace[1467545934] transaction","detail":"{read_only:false; response_revision:26432; number_of_response:1; }","duration":"147.449869ms","start":"2026-07-10T22:19:59.33861Z","end":"2026-07-10T22:19:59.48606Z","steps":["trace[1467545934] 'process raft request'  (duration: 112.539927ms)","trace[1467545934] 'compare'  (duration: 34.764379ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:59.99735Z","caller":"traceutil/trace.go:171","msg":"trace[1565721899] linearizableReadLoop","detail":"{readStateIndex:27295; appliedIndex:27294; }","duration":"254.175806ms","start":"2026-07-10T22:19:59.743151Z","end":"2026-07-10T22:19:59.997327Z","steps":["trace[1565721899] 'read index received'  (duration: 254.029713ms)","trace[1565721899] 'applied index is now lower than readState.Index'  (duration: 144.953µs)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:19:59.997473Z","caller":"traceutil/trace.go:171","msg":"trace[1828028507] transaction","detail":"{read_only:false; response_revision:26438; number_of_response:1; }","duration":"259.811534ms","start":"2026-07-10T22:19:59.737609Z","end":"2026-07-10T22:19:59.997421Z","steps":["trace[1828028507] 'process raft request'  (duration: 259.578688ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:19:59.997545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.372671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:19:59.997634Z","caller":"traceutil/trace.go:171","msg":"trace[1509526222] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:26438; }","duration":"254.511774ms","start":"2026-07-10T22:19:59.743102Z","end":"2026-07-10T22:19:59.997614Z","steps":["trace[1509526222] 'agreement among raft nodes before linearized reading'  (duration: 254.34793ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:00.032822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.548492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:20:00.032878Z","caller":"traceutil/trace.go:171","msg":"trace[1235726733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26441; }","duration":"240.652035ms","start":"2026-07-10T22:19:59.792215Z","end":"2026-07-10T22:20:00.032867Z","steps":["trace[1235726733] 'agreement among raft nodes before linearized reading'  (duration: 240.543882ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:00.03318Z","caller":"traceutil/trace.go:171","msg":"trace[343091039] transaction","detail":"{read_only:false; response_revision:26439; number_of_response:1; }","duration":"269.604184ms","start":"2026-07-10T22:19:59.76357Z","end":"2026-07-10T22:20:00.033174Z","steps":["trace[343091039] 'process raft request'  (duration: 269.037289ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:00.033263Z","caller":"traceutil/trace.go:171","msg":"trace[663333372] transaction","detail":"{read_only:false; response_revision:26440; number_of_response:1; }","duration":"102.131504ms","start":"2026-07-10T22:19:59.931127Z","end":"2026-07-10T22:20:00.033258Z","steps":["trace[663333372] 'process raft request'  (duration: 101.575809ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:01.726454Z","caller":"traceutil/trace.go:171","msg":"trace[1114666696] transaction","detail":"{read_only:false; response_revision:26467; number_of_response:1; }","duration":"168.294689ms","start":"2026-07-10T22:20:01.558128Z","end":"2026-07-10T22:20:01.726423Z","steps":["trace[1114666696] 'process raft request'  (duration: 110.416055ms)","trace[1114666696] 'compare'  (duration: 57.71287ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:20:01.72822Z","caller":"traceutil/trace.go:171","msg":"trace[1708155676] transaction","detail":"{read_only:false; response_revision:26468; number_of_response:1; }","duration":"166.231569ms","start":"2026-07-10T22:20:01.561962Z","end":"2026-07-10T22:20:01.728194Z","steps":["trace[1708155676] 'process raft request'  (duration: 166.040505ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:01.728508Z","caller":"traceutil/trace.go:171","msg":"trace[550748518] transaction","detail":"{read_only:false; response_revision:26469; number_of_response:1; }","duration":"163.636396ms","start":"2026-07-10T22:20:01.564844Z","end":"2026-07-10T22:20:01.72848Z","steps":["trace[550748518] 'process raft request'  (duration: 163.303948ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:01.728731Z","caller":"traceutil/trace.go:171","msg":"trace[1279549762] linearizableReadLoop","detail":"{readStateIndex:27327; appliedIndex:27324; }","duration":"109.471373ms","start":"2026-07-10T22:20:01.619244Z","end":"2026-07-10T22:20:01.728715Z","steps":["trace[1279549762] 'read index received'  (duration: 49.319313ms)","trace[1279549762] 'applied index is now lower than readState.Index'  (duration: 60.15121ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:20:01.729191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.933034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-engine-cleaner-29728700-bvjzt\" ","response":"range_response_count:1 size:6983"}
{"level":"info","ts":"2026-07-10T22:20:01.729243Z","caller":"traceutil/trace.go:171","msg":"trace[978455283] range","detail":"{range_begin:/registry/pods/openstack/heat-engine-cleaner-29728700-bvjzt; range_end:; response_count:1; response_revision:26470; }","duration":"109.996685ms","start":"2026-07-10T22:20:01.619231Z","end":"2026-07-10T22:20:01.729228Z","steps":["trace[978455283] 'agreement among raft nodes before linearized reading'  (duration: 109.836971ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:01.903024Z","caller":"traceutil/trace.go:171","msg":"trace[60455169] transaction","detail":"{read_only:false; response_revision:26471; number_of_response:1; }","duration":"163.955273ms","start":"2026-07-10T22:20:01.739053Z","end":"2026-07-10T22:20:01.903008Z","steps":["trace[60455169] 'process raft request'  (duration: 154.695847ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:01.902982Z","caller":"traceutil/trace.go:171","msg":"trace[360815092] linearizableReadLoop","detail":"{readStateIndex:27329; appliedIndex:27328; }","duration":"110.813405ms","start":"2026-07-10T22:20:01.792143Z","end":"2026-07-10T22:20:01.902956Z","steps":["trace[360815092] 'read index received'  (duration: 101.631351ms)","trace[360815092] 'applied index is now lower than readState.Index'  (duration: 9.180794ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:20:01.90321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.05073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:20:01.903295Z","caller":"traceutil/trace.go:171","msg":"trace[975401114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26471; }","duration":"111.184275ms","start":"2026-07-10T22:20:01.792092Z","end":"2026-07-10T22:20:01.903276Z","steps":["trace[975401114] 'agreement among raft nodes before linearized reading'  (duration: 111.044791ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:07.73014Z","caller":"traceutil/trace.go:171","msg":"trace[1878335346] transaction","detail":"{read_only:false; response_revision:26526; number_of_response:1; }","duration":"110.330854ms","start":"2026-07-10T22:20:07.619783Z","end":"2026-07-10T22:20:07.730114Z","steps":["trace[1878335346] 'process raft request'  (duration: 110.17653ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:07.933834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.322914ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884930 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26515 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:20:07.933977Z","caller":"traceutil/trace.go:171","msg":"trace[1582881910] transaction","detail":"{read_only:false; response_revision:26527; number_of_response:1; }","duration":"184.473184ms","start":"2026-07-10T22:20:07.749442Z","end":"2026-07-10T22:20:07.933915Z","steps":["trace[1582881910] 'process raft request'  (duration: 39.983876ms)","trace[1582881910] 'compare'  (duration: 144.037727ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:20:07.972604Z","caller":"traceutil/trace.go:171","msg":"trace[1315090239] transaction","detail":"{read_only:false; response_revision:26528; number_of_response:1; }","duration":"222.641126ms","start":"2026-07-10T22:20:07.749941Z","end":"2026-07-10T22:20:07.972582Z","steps":["trace[1315090239] 'process raft request'  (duration: 222.39272ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:07.972788Z","caller":"traceutil/trace.go:171","msg":"trace[2096608800] transaction","detail":"{read_only:false; response_revision:26529; number_of_response:1; }","duration":"222.827111ms","start":"2026-07-10T22:20:07.74995Z","end":"2026-07-10T22:20:07.972777Z","steps":["trace[2096608800] 'process raft request'  (duration: 222.514003ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:07.972778Z","caller":"traceutil/trace.go:171","msg":"trace[1276322047] linearizableReadLoop","detail":"{readStateIndex:27388; appliedIndex:27386; }","duration":"179.984514ms","start":"2026-07-10T22:20:07.792762Z","end":"2026-07-10T22:20:07.972746Z","steps":["trace[1276322047] 'read index received'  (duration: 179.477982ms)","trace[1276322047] 'applied index is now lower than readState.Index'  (duration: 504.892µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-10T22:20:07.972938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.152688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-10T22:20:07.972952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.485257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:20:07.972991Z","caller":"traceutil/trace.go:171","msg":"trace[707449940] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26529; }","duration":"101.5773ms","start":"2026-07-10T22:20:07.871402Z","end":"2026-07-10T22:20:07.972979Z","steps":["trace[707449940] 'agreement among raft nodes before linearized reading'  (duration: 101.490458ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:07.972981Z","caller":"traceutil/trace.go:171","msg":"trace[401174191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26529; }","duration":"180.255551ms","start":"2026-07-10T22:20:07.792715Z","end":"2026-07-10T22:20:07.97297Z","steps":["trace[401174191] 'agreement among raft nodes before linearized reading'  (duration: 180.119347ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:08.381028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.732692ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15342813187598884937 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26518 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-10T22:20:08.381171Z","caller":"traceutil/trace.go:171","msg":"trace[966730064] linearizableReadLoop","detail":"{readStateIndex:27391; appliedIndex:27389; }","duration":"203.600691ms","start":"2026-07-10T22:20:08.177557Z","end":"2026-07-10T22:20:08.381158Z","steps":["trace[966730064] 'read index received'  (duration: 74.701564ms)","trace[966730064] 'applied index is now lower than readState.Index'  (duration: 128.898067ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:20:08.381244Z","caller":"traceutil/trace.go:171","msg":"trace[986751179] transaction","detail":"{read_only:false; response_revision:26531; number_of_response:1; }","duration":"270.343451ms","start":"2026-07-10T22:20:08.110892Z","end":"2026-07-10T22:20:08.381235Z","steps":["trace[986751179] 'process raft request'  (duration: 141.327451ms)","trace[986751179] 'compare'  (duration: 128.609729ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:20:08.381401Z","caller":"traceutil/trace.go:171","msg":"trace[1196579064] transaction","detail":"{read_only:false; response_revision:26532; number_of_response:1; }","duration":"269.09122ms","start":"2026-07-10T22:20:08.112285Z","end":"2026-07-10T22:20:08.381376Z","steps":["trace[1196579064] 'process raft request'  (duration: 268.826564ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:08.381492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.92819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-07-10T22:20:08.381552Z","caller":"traceutil/trace.go:171","msg":"trace[906268104] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26532; }","duration":"204.224816ms","start":"2026-07-10T22:20:08.177311Z","end":"2026-07-10T22:20:08.381536Z","steps":["trace[906268104] 'agreement among raft nodes before linearized reading'  (duration: 204.032662ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:08.582781Z","caller":"traceutil/trace.go:171","msg":"trace[1568411132] transaction","detail":"{read_only:false; response_revision:26533; number_of_response:1; }","duration":"197.456872ms","start":"2026-07-10T22:20:08.385294Z","end":"2026-07-10T22:20:08.582751Z","steps":["trace[1568411132] 'process raft request'  (duration: 183.600793ms)","trace[1568411132] 'compare'  (duration: 13.52837ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:20:08.583103Z","caller":"traceutil/trace.go:171","msg":"trace[2041381663] transaction","detail":"{read_only:false; response_revision:26534; number_of_response:1; }","duration":"197.737699ms","start":"2026-07-10T22:20:08.385293Z","end":"2026-07-10T22:20:08.583031Z","steps":["trace[2041381663] 'process raft request'  (duration: 197.37977ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:08.588074Z","caller":"traceutil/trace.go:171","msg":"trace[1103677707] transaction","detail":"{read_only:false; response_revision:26535; number_of_response:1; }","duration":"201.064298ms","start":"2026-07-10T22:20:08.386994Z","end":"2026-07-10T22:20:08.588058Z","steps":["trace[1103677707] 'process raft request'  (duration: 200.977316ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:09.041357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.575764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-07-10T22:20:09.041403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.02108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-10T22:20:09.041425Z","caller":"traceutil/trace.go:171","msg":"trace[477860062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26535; }","duration":"342.688227ms","start":"2026-07-10T22:20:08.698723Z","end":"2026-07-10T22:20:09.041411Z","steps":["trace[477860062] 'range keys from in-memory index tree'  (duration: 342.418721ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:09.04145Z","caller":"traceutil/trace.go:171","msg":"trace[1225290264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26535; }","duration":"138.153723ms","start":"2026-07-10T22:20:08.903285Z","end":"2026-07-10T22:20:09.041438Z","steps":["trace[1225290264] 'range keys from in-memory index tree'  (duration: 137.725473ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:09.04146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T22:20:08.698674Z","time spent":"342.779309ms","remote":"127.0.0.1:54306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-07-10T22:20:11.197255Z","caller":"traceutil/trace.go:171","msg":"trace[1907412718] transaction","detail":"{read_only:false; response_revision:26553; number_of_response:1; }","duration":"126.848346ms","start":"2026-07-10T22:20:11.070388Z","end":"2026-07-10T22:20:11.197237Z","steps":["trace[1907412718] 'process raft request'  (duration: 126.728383ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:11.259068Z","caller":"traceutil/trace.go:171","msg":"trace[1824580350] linearizableReadLoop","detail":"{readStateIndex:27415; appliedIndex:27412; }","duration":"138.864331ms","start":"2026-07-10T22:20:11.120186Z","end":"2026-07-10T22:20:11.25905Z","steps":["trace[1824580350] 'read index received'  (duration: 77.023122ms)","trace[1824580350] 'applied index is now lower than readState.Index'  (duration: 61.840399ms)"],"step_count":2}
{"level":"info","ts":"2026-07-10T22:20:11.259332Z","caller":"traceutil/trace.go:171","msg":"trace[1673415492] transaction","detail":"{read_only:false; response_revision:26555; number_of_response:1; }","duration":"184.773131ms","start":"2026-07-10T22:20:11.074358Z","end":"2026-07-10T22:20:11.259132Z","steps":["trace[1673415492] 'process raft request'  (duration: 184.668149ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-10T22:20:11.259376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.175559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-10T22:20:11.2594Z","caller":"traceutil/trace.go:171","msg":"trace[1276321406] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:26555; }","duration":"139.252971ms","start":"2026-07-10T22:20:11.120141Z","end":"2026-07-10T22:20:11.259394Z","steps":["trace[1276321406] 'agreement among raft nodes before linearized reading'  (duration: 138.977824ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:11.259138Z","caller":"traceutil/trace.go:171","msg":"trace[700048615] transaction","detail":"{read_only:false; response_revision:26554; number_of_response:1; }","duration":"186.126475ms","start":"2026-07-10T22:20:11.072984Z","end":"2026-07-10T22:20:11.259111Z","steps":["trace[700048615] 'process raft request'  (duration: 185.893459ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:20:32.138538Z","caller":"traceutil/trace.go:171","msg":"trace[1618559207] transaction","detail":"{read_only:false; response_revision:26735; number_of_response:1; }","duration":"105.822014ms","start":"2026-07-10T22:20:32.032692Z","end":"2026-07-10T22:20:32.138514Z","steps":["trace[1618559207] 'process raft request'  (duration: 105.671641ms)"],"step_count":1}
{"level":"info","ts":"2026-07-10T22:22:52.323611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25165}
{"level":"info","ts":"2026-07-10T22:22:52.471149Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25165,"took":"142.266623ms","hash":2635990271,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":38588416,"current-db-size-in-use":"39 MB"}
{"level":"info","ts":"2026-07-10T22:22:52.471223Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2635990271,"revision":25165,"compact-revision":21976}
{"level":"info","ts":"2026-07-10T22:24:21.824698Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-10T22:24:21.842975Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-07-10T22:24:21.843062Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-07-10T22:27:52.332207Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28153}
{"level":"info","ts":"2026-07-10T22:27:52.464749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28153,"took":"128.867243ms","hash":2605727070,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":34123776,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-10T22:27:52.464819Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2605727070,"revision":28153,"compact-revision":25165}
{"level":"info","ts":"2026-07-10T22:32:52.338485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30695}
{"level":"info","ts":"2026-07-10T22:32:52.478204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30695,"took":"136.417461ms","hash":1685587345,"current-db-size-bytes":59379712,"current-db-size":"59 MB","current-db-size-in-use-bytes":30949376,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-10T22:32:52.47826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1685587345,"revision":30695,"compact-revision":28153}
{"level":"info","ts":"2026-07-10T22:37:52.34639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32963}
{"level":"info","ts":"2026-07-10T22:37:52.506843Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32963,"took":"156.729127ms","hash":464855294,"current-db-size-bytes":60424192,"current-db-size":"60 MB","current-db-size-in-use-bytes":30629888,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-10T22:37:52.506986Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":464855294,"revision":32963,"compact-revision":30695}
{"level":"info","ts":"2026-07-10T22:42:52.353774Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35217}
{"level":"info","ts":"2026-07-10T22:42:52.499521Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35217,"took":"139.349503ms","hash":439529455,"current-db-size-bytes":60424192,"current-db-size":"60 MB","current-db-size-in-use-bytes":31076352,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-10T22:42:52.499615Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":439529455,"revision":35217,"compact-revision":32963}
{"level":"info","ts":"2026-07-10T22:45:33.538795Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-10T22:45:33.544101Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-07-10T22:45:33.54417Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}