{"level":"warn","ts":"2026-09-07T18:15:25.294567Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-07T18:15:25.294825Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.5: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://162.253.55.5:2380","--initial-cluster=instance=https://162.253.55.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.5: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-09-07T18:15:25.296869Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-07T18:15:25.296941Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-09-07T18:15:25.296987Z","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-09-07T18:15:25.298302Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"]}
{"level":"info","ts":"2026-09-07T18:15:25.298475Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.5: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-09-07T18:15:25.305953Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.161123ms"}
{"level":"info","ts":"2026-09-07T18:15:25.314813Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b512f7d8ac93be25","cluster-id":"e1953d9a3e7368e5"}
{"level":"info","ts":"2026-09-07T18:15:25.314913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-07T18:15:25.314945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 0"}
{"level":"info","ts":"2026-09-07T18:15:25.314964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b512f7d8ac93be25 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-07T18:15:25.314973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 1"}
{"level":"info","ts":"2026-09-07T18:15:25.315016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"warn","ts":"2026-09-07T18:15:25.334457Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-07T18:15:25.336189Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-07T18:15:25.337425Z","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-09-07T18:15:25.339594Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b512f7d8ac93be25","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-07T18:15:25.339696Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b512f7d8ac93be25","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-07T18:15:25.343965Z","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-09-07T18:15:25.344021Z","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-09-07T18:15:25.344035Z","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-09-07T18:15:25.344357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"info","ts":"2026-09-07T18:15:25.344586Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","added-peer-id":"b512f7d8ac93be25","added-peer-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-09-07T18:15:25.349024Z","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-09-07T18:15:25.349172Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-09-07T18:15:25.349247Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-09-07T18:15:25.349458Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b512f7d8ac93be25","initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-07T18:15:25.349526Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-07T18:15:25.415598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-07T18:15:25.415735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-07T18:15:25.415847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgPreVoteResp from b512f7d8ac93be25 at term 1"}
{"level":"info","ts":"2026-09-07T18:15:25.415877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became candidate at term 2"}
{"level":"info","ts":"2026-09-07T18:15:25.415924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgVoteResp from b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-09-07T18:15:25.415961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became leader at term 2"}
{"level":"info","ts":"2026-09-07T18:15:25.416021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b512f7d8ac93be25 elected leader b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-09-07T18:15:25.41971Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b512f7d8ac93be25","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.5:2379]}","request-path":"/0/members/b512f7d8ac93be25/attributes","cluster-id":"e1953d9a3e7368e5","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-07T18:15:25.419733Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T18:15:25.419773Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T18:15:25.421091Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T18:15:25.421229Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T18:15:25.421271Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T18:15:25.421324Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T18:15:25.42249Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-07T18:15:25.422534Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-07T18:15:25.423358Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.5:2379"}
{"level":"info","ts":"2026-09-07T18:15:25.429653Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-09-07T18:15:31.241228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.33942ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13701533900428772674 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/kube-public/cluster-info\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-public/cluster-info\" value_size:1889 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-07T18:15:31.241428Z","caller":"traceutil/trace.go:171","msg":"trace[1627615150] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"136.894378ms","start":"2026-09-07T18:15:31.104499Z","end":"2026-09-07T18:15:31.241393Z","steps":["trace[1627615150] 'process raft request'  (duration: 17.895794ms)","trace[1627615150] 'compare'  (duration: 118.216621ms)"],"step_count":2}
2026/09/07 18:15:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-09-07T18:15:48.182176Z","caller":"traceutil/trace.go:171","msg":"trace[550828389] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"115.902968ms","start":"2026-09-07T18:15:48.066241Z","end":"2026-09-07T18:15:48.182144Z","steps":["trace[550828389] 'process raft request'  (duration: 115.685407ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:15:48.184001Z","caller":"traceutil/trace.go:171","msg":"trace[1509291108] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"116.22497ms","start":"2026-09-07T18:15:48.067752Z","end":"2026-09-07T18:15:48.183977Z","steps":["trace[1509291108] 'process raft request'  (duration: 116.076809ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:27.167913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.001528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:16:27.168007Z","caller":"traceutil/trace.go:171","msg":"trace[511290511] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:622; }","duration":"184.176093ms","start":"2026-09-07T18:16:26.983811Z","end":"2026-09-07T18:16:27.167987Z","steps":["trace[511290511] 'range keys from in-memory index tree'  (duration: 183.907296ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:16:29.391284Z","caller":"traceutil/trace.go:171","msg":"trace[979647723] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"117.603025ms","start":"2026-09-07T18:16:29.27365Z","end":"2026-09-07T18:16:29.391253Z","steps":["trace[979647723] 'process raft request'  (duration: 117.015878ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:16:30.537188Z","caller":"traceutil/trace.go:171","msg":"trace[52817561] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"158.930756ms","start":"2026-09-07T18:16:30.378234Z","end":"2026-09-07T18:16:30.537165Z","steps":["trace[52817561] 'process raft request'  (duration: 157.295027ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.173037Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13701533900428773510,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-09-07T18:16:31.203097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.073584ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:16:31.203286Z","caller":"traceutil/trace.go:171","msg":"trace[913723494] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:647; }","duration":"142.279681ms","start":"2026-09-07T18:16:31.060972Z","end":"2026-09-07T18:16:31.203252Z","steps":["trace[913723494] 'range keys from in-memory index tree'  (duration: 141.665852ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.203576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.915426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:16:31.203728Z","caller":"traceutil/trace.go:171","msg":"trace[1574255588] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:647; }","duration":"580.289617ms","start":"2026-09-07T18:16:30.623414Z","end":"2026-09-07T18:16:31.203703Z","steps":["trace[1574255588] 'count revisions from in-memory index tree'  (duration: 579.519242ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.203776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:16:30.623382Z","time spent":"580.37936ms","remote":"127.0.0.1:52224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"info","ts":"2026-09-07T18:16:31.204109Z","caller":"traceutil/trace.go:171","msg":"trace[194552749] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"531.381753ms","start":"2026-09-07T18:16:30.67263Z","end":"2026-09-07T18:16:31.204012Z","steps":["trace[194552749] 'read index received'  (duration: 531.209418ms)","trace[194552749] 'applied index is now lower than readState.Index'  (duration: 171.405µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:16:31.20415Z","caller":"traceutil/trace.go:171","msg":"trace[274181800] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"572.943565ms","start":"2026-09-07T18:16:30.631191Z","end":"2026-09-07T18:16:31.204135Z","steps":["trace[274181800] 'process raft request'  (duration: 572.654326ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.204242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:16:30.631161Z","time spent":"573.019717ms","remote":"127.0.0.1:52334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-09-07T18:16:31.204328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.681711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:16:31.204414Z","caller":"traceutil/trace.go:171","msg":"trace[1053473546] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:648; }","duration":"531.777184ms","start":"2026-09-07T18:16:30.67261Z","end":"2026-09-07T18:16:31.204388Z","steps":["trace[1053473546] 'agreement among raft nodes before linearized reading'  (duration: 531.546267ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.204475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:16:30.672537Z","time spent":"531.921229ms","remote":"127.0.0.1:52220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-09-07T18:16:31.204567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.353826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-98cgg\" ","response":"range_response_count:1 size:16957"}
{"level":"info","ts":"2026-09-07T18:16:31.204666Z","caller":"traceutil/trace.go:171","msg":"trace[1912832477] range","detail":"{range_begin:/registry/pods/kube-system/cilium-98cgg; range_end:; response_count:1; response_revision:648; }","duration":"307.503881ms","start":"2026-09-07T18:16:30.897136Z","end":"2026-09-07T18:16:31.204639Z","steps":["trace[1912832477] 'agreement among raft nodes before linearized reading'  (duration: 307.19482ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.204717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:16:30.897076Z","time spent":"307.631455ms","remote":"127.0.0.1:52182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16981,"request content":"key:\"/registry/pods/kube-system/cilium-98cgg\" "}
{"level":"warn","ts":"2026-09-07T18:16:31.204703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.464209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T18:16:31.204946Z","caller":"traceutil/trace.go:171","msg":"trace[837232083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"379.761158ms","start":"2026-09-07T18:16:30.825154Z","end":"2026-09-07T18:16:31.204915Z","steps":["trace[837232083] 'agreement among raft nodes before linearized reading'  (duration: 379.073646ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:16:31.20501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:16:30.825127Z","time spent":"379.866911ms","remote":"127.0.0.1:52244","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-09-07T18:16:48.247444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.235592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-09-07T18:16:48.247588Z","caller":"traceutil/trace.go:171","msg":"trace[941625567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:818; }","duration":"115.446059ms","start":"2026-09-07T18:16:48.132111Z","end":"2026-09-07T18:16:48.247557Z","steps":["trace[941625567] 'range keys from in-memory index tree'  (duration: 115.045234ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:16:48.434912Z","caller":"traceutil/trace.go:171","msg":"trace[1752321398] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"182.100443ms","start":"2026-09-07T18:16:48.252786Z","end":"2026-09-07T18:16:48.434887Z","steps":["trace[1752321398] 'process raft request'  (duration: 181.903596ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:17:20.00774Z","caller":"traceutil/trace.go:171","msg":"trace[390372236] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"164.865502ms","start":"2026-09-07T18:17:19.842854Z","end":"2026-09-07T18:17:20.007719Z","steps":["trace[390372236] 'read index received'  (duration: 164.722695ms)","trace[390372236] 'applied index is now lower than readState.Index'  (duration: 141.817µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T18:17:20.007865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.995897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T18:17:20.007894Z","caller":"traceutil/trace.go:171","msg":"trace[475932114] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1226; }","duration":"165.089071ms","start":"2026-09-07T18:17:19.842795Z","end":"2026-09-07T18:17:20.007884Z","steps":["trace[475932114] 'agreement among raft nodes before linearized reading'  (duration: 165.011477ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:17:20.008101Z","caller":"traceutil/trace.go:171","msg":"trace[60579880] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"295.234544ms","start":"2026-09-07T18:17:19.712854Z","end":"2026-09-07T18:17:20.008088Z","steps":["trace[60579880] 'process raft request'  (duration: 294.737162ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:17:43.21951Z","caller":"traceutil/trace.go:171","msg":"trace[820555184] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"183.335424ms","start":"2026-09-07T18:17:43.03614Z","end":"2026-09-07T18:17:43.219475Z","steps":["trace[820555184] 'process raft request'  (duration: 96.431963ms)","trace[820555184] 'compare'  (duration: 86.326633ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:17:43.219518Z","caller":"traceutil/trace.go:171","msg":"trace[844116556] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"182.084345ms","start":"2026-09-07T18:17:43.037367Z","end":"2026-09-07T18:17:43.219451Z","steps":["trace[844116556] 'process raft request'  (duration: 181.681095ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:17:55.606728Z","caller":"traceutil/trace.go:171","msg":"trace[2001107940] transaction","detail":"{read_only:false; response_revision:1647; number_of_response:1; }","duration":"122.92156ms","start":"2026-09-07T18:17:55.483774Z","end":"2026-09-07T18:17:55.606696Z","steps":["trace[2001107940] 'process raft request'  (duration: 84.436501ms)","trace[2001107940] 'compare'  (duration: 38.089339ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:17:55.607136Z","caller":"traceutil/trace.go:171","msg":"trace[282486002] transaction","detail":"{read_only:false; response_revision:1648; number_of_response:1; }","duration":"117.994899ms","start":"2026-09-07T18:17:55.489122Z","end":"2026-09-07T18:17:55.607117Z","steps":["trace[282486002] 'process raft request'  (duration: 117.8069ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:17:55.607345Z","caller":"traceutil/trace.go:171","msg":"trace[1136380283] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"116.247064ms","start":"2026-09-07T18:17:55.49105Z","end":"2026-09-07T18:17:55.607297Z","steps":["trace[1136380283] 'process raft request'  (duration: 115.993271ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:17:55.607284Z","caller":"traceutil/trace.go:171","msg":"trace[731036060] linearizableReadLoop","detail":"{readStateIndex:1719; appliedIndex:1717; }","duration":"117.256903ms","start":"2026-09-07T18:17:55.489962Z","end":"2026-09-07T18:17:55.607219Z","steps":["trace[731036060] 'read index received'  (duration: 15.835843ms)","trace[731036060] 'applied index is now lower than readState.Index'  (duration: 101.4199ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T18:17:55.60778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.788409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:17:55.607868Z","caller":"traceutil/trace.go:171","msg":"trace[1281277520] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:1650; }","duration":"117.920175ms","start":"2026-09-07T18:17:55.489928Z","end":"2026-09-07T18:17:55.607848Z","steps":["trace[1281277520] 'agreement among raft nodes before linearized reading'  (duration: 117.781148ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:17:55.811039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.994815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/openstack/rabbitmq-messaging-topology-operator-7f8596f788\" ","response":"range_response_count:1 size:5803"}
{"level":"info","ts":"2026-09-07T18:17:55.811406Z","caller":"traceutil/trace.go:171","msg":"trace[1739039259] range","detail":"{range_begin:/registry/replicasets/openstack/rabbitmq-messaging-topology-operator-7f8596f788; range_end:; response_count:1; response_revision:1669; }","duration":"104.801644ms","start":"2026-09-07T18:17:55.706583Z","end":"2026-09-07T18:17:55.811385Z","steps":["trace[1739039259] 'agreement among raft nodes before linearized reading'  (duration: 103.919091ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:13.172015Z","caller":"traceutil/trace.go:171","msg":"trace[1446257111] linearizableReadLoop","detail":"{readStateIndex:1995; appliedIndex:1994; }","duration":"249.118831ms","start":"2026-09-07T18:18:12.922872Z","end":"2026-09-07T18:18:13.171991Z","steps":["trace[1446257111] 'read index received'  (duration: 248.875907ms)","trace[1446257111] 'applied index is now lower than readState.Index'  (duration: 242.173µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:18:13.172132Z","caller":"traceutil/trace.go:171","msg":"trace[1405212400] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"386.261969ms","start":"2026-09-07T18:18:12.785851Z","end":"2026-09-07T18:18:13.172113Z","steps":["trace[1405212400] 'process raft request'  (duration: 385.968914ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:13.172238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.342232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-07T18:18:13.172278Z","caller":"traceutil/trace.go:171","msg":"trace[768186691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1915; }","duration":"249.448507ms","start":"2026-09-07T18:18:12.922817Z","end":"2026-09-07T18:18:13.172266Z","steps":["trace[768186691] 'agreement among raft nodes before linearized reading'  (duration: 249.29794ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:13.172469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:18:12.785825Z","time spent":"386.356473ms","remote":"127.0.0.1:52244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1880 > 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-09-07T18:18:13.649893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.892101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-95b7caa7-7055-426c-8e6a-f1c6171be39e\" ","response":"range_response_count:1 size:3625"}
{"level":"info","ts":"2026-09-07T18:18:13.650018Z","caller":"traceutil/trace.go:171","msg":"trace[1046197325] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-95b7caa7-7055-426c-8e6a-f1c6171be39e; range_end:; response_count:1; response_revision:1917; }","duration":"240.094192ms","start":"2026-09-07T18:18:13.409895Z","end":"2026-09-07T18:18:13.649989Z","steps":["trace[1046197325] 'range keys from in-memory index tree'  (duration: 239.524733ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:13.650227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.33976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-07T18:18:13.650607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.242324ms","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-09-07T18:18:13.651161Z","caller":"traceutil/trace.go:171","msg":"trace[1923634198] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1917; }","duration":"273.857645ms","start":"2026-09-07T18:18:13.377245Z","end":"2026-09-07T18:18:13.651103Z","steps":["trace[1923634198] 'range keys from in-memory index tree'  (duration: 273.014523ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:13.650669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.956611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-07T18:18:13.651236Z","caller":"traceutil/trace.go:171","msg":"trace[1244725718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1917; }","duration":"253.556401ms","start":"2026-09-07T18:18:13.397663Z","end":"2026-09-07T18:18:13.651219Z","steps":["trace[1244725718] 'range keys from in-memory index tree'  (duration: 252.743989ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:13.650956Z","caller":"traceutil/trace.go:171","msg":"trace[1268359067] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1917; }","duration":"234.090709ms","start":"2026-09-07T18:18:13.416823Z","end":"2026-09-07T18:18:13.650914Z","steps":["trace[1268359067] 'count revisions from in-memory index tree'  (duration: 233.282148ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:25.390325Z","caller":"traceutil/trace.go:171","msg":"trace[1806128805] linearizableReadLoop","detail":"{readStateIndex:2098; appliedIndex:2097; }","duration":"130.672034ms","start":"2026-09-07T18:18:25.259617Z","end":"2026-09-07T18:18:25.390289Z","steps":["trace[1806128805] 'read index received'  (duration: 117.334559ms)","trace[1806128805] 'applied index is now lower than readState.Index'  (duration: 13.335365ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:18:25.390434Z","caller":"traceutil/trace.go:171","msg":"trace[159985072] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"177.286786ms","start":"2026-09-07T18:18:25.213104Z","end":"2026-09-07T18:18:25.390391Z","steps":["trace[159985072] 'process raft request'  (duration: 163.828065ms)","trace[159985072] 'compare'  (duration: 13.190628ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T18:18:25.390618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.99115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-09-07T18:18:25.390704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.477877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-09-07T18:18:25.390761Z","caller":"traceutil/trace.go:171","msg":"trace[966659986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2015; }","duration":"124.605383ms","start":"2026-09-07T18:18:25.266143Z","end":"2026-09-07T18:18:25.390748Z","steps":["trace[966659986] 'agreement among raft nodes before linearized reading'  (duration: 124.395883ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:25.390775Z","caller":"traceutil/trace.go:171","msg":"trace[763500198] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2015; }","duration":"131.154569ms","start":"2026-09-07T18:18:25.259571Z","end":"2026-09-07T18:18:25.390726Z","steps":["trace[763500198] 'agreement among raft nodes before linearized reading'  (duration: 130.803551ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:29.551672Z","caller":"traceutil/trace.go:171","msg":"trace[258438996] linearizableReadLoop","detail":"{readStateIndex:2129; appliedIndex:2128; }","duration":"126.569076ms","start":"2026-09-07T18:18:29.425079Z","end":"2026-09-07T18:18:29.551648Z","steps":["trace[258438996] 'read index received'  (duration: 126.402438ms)","trace[258438996] 'applied index is now lower than readState.Index'  (duration: 165.638µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:18:29.551786Z","caller":"traceutil/trace.go:171","msg":"trace[122026911] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"135.790631ms","start":"2026-09-07T18:18:29.415964Z","end":"2026-09-07T18:18:29.551754Z","steps":["trace[122026911] 'process raft request'  (duration: 135.536118ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:29.552039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.881782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-07T18:18:29.552125Z","caller":"traceutil/trace.go:171","msg":"trace[779221529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2046; }","duration":"121.02867ms","start":"2026-09-07T18:18:29.431073Z","end":"2026-09-07T18:18:29.552102Z","steps":["trace[779221529] 'agreement among raft nodes before linearized reading'  (duration: 120.770787ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:29.552435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.345115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-07T18:18:29.552501Z","caller":"traceutil/trace.go:171","msg":"trace[1604586009] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2046; }","duration":"127.474504ms","start":"2026-09-07T18:18:29.425Z","end":"2026-09-07T18:18:29.552474Z","steps":["trace[1604586009] 'agreement among raft nodes before linearized reading'  (duration: 126.770197ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:30.017142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:18:29.631086Z","time spent":"386.051425ms","remote":"127.0.0.1:52076","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-09-07T18:18:30.018506Z","caller":"traceutil/trace.go:171","msg":"trace[821198706] linearizableReadLoop","detail":"{readStateIndex:2133; appliedIndex:2131; }","duration":"200.359992ms","start":"2026-09-07T18:18:29.818125Z","end":"2026-09-07T18:18:30.018485Z","steps":["trace[821198706] 'read index received'  (duration: 198.721868ms)","trace[821198706] 'applied index is now lower than readState.Index'  (duration: 1.637224ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:18:30.018679Z","caller":"traceutil/trace.go:171","msg":"trace[1757091119] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"240.211506ms","start":"2026-09-07T18:18:29.778448Z","end":"2026-09-07T18:18:30.018659Z","steps":["trace[1757091119] 'process raft request'  (duration: 239.868728ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:30.019018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.868239ms","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-09-07T18:18:30.019166Z","caller":"traceutil/trace.go:171","msg":"trace[1029610044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2049; }","duration":"201.061799ms","start":"2026-09-07T18:18:29.818087Z","end":"2026-09-07T18:18:30.019149Z","steps":["trace[1029610044] 'agreement among raft nodes before linearized reading'  (duration: 200.608645ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:30.020313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.777875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-07T18:18:30.020538Z","caller":"traceutil/trace.go:171","msg":"trace[666826249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2050; }","duration":"202.019248ms","start":"2026-09-07T18:18:29.8185Z","end":"2026-09-07T18:18:30.020519Z","steps":["trace[666826249] 'agreement among raft nodes before linearized reading'  (duration: 201.67214ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:52.078314Z","caller":"traceutil/trace.go:171","msg":"trace[1281113631] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"108.68236ms","start":"2026-09-07T18:18:51.969595Z","end":"2026-09-07T18:18:52.078277Z","steps":["trace[1281113631] 'process raft request'  (duration: 108.380094ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:18:52.264934Z","caller":"traceutil/trace.go:171","msg":"trace[2146366423] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"109.169518ms","start":"2026-09-07T18:18:52.155728Z","end":"2026-09-07T18:18:52.264898Z","steps":["trace[2146366423] 'read index received'  (duration: 22.055802ms)","trace[2146366423] 'applied index is now lower than readState.Index'  (duration: 87.112415ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:18:52.265111Z","caller":"traceutil/trace.go:171","msg":"trace[518797336] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"130.298913ms","start":"2026-09-07T18:18:52.134792Z","end":"2026-09-07T18:18:52.265091Z","steps":["trace[518797336] 'process raft request'  (duration: 43.007308ms)","trace[518797336] 'compare'  (duration: 86.920314ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T18:18:52.265464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.714686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-09-07T18:18:52.265529Z","caller":"traceutil/trace.go:171","msg":"trace[844109342] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2174; }","duration":"109.873014ms","start":"2026-09-07T18:18:52.155639Z","end":"2026-09-07T18:18:52.265512Z","steps":["trace[844109342] 'agreement among raft nodes before linearized reading'  (duration: 109.655933ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:52.869095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.417897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:18:52.869235Z","caller":"traceutil/trace.go:171","msg":"trace[345077369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2179; }","duration":"100.661169ms","start":"2026-09-07T18:18:52.768547Z","end":"2026-09-07T18:18:52.869208Z","steps":["trace[345077369] 'range keys from in-memory index tree'  (duration: 100.247497ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:52.869311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.143728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T18:18:52.869371Z","caller":"traceutil/trace.go:171","msg":"trace[830158731] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2179; }","duration":"376.277035ms","start":"2026-09-07T18:18:52.493078Z","end":"2026-09-07T18:18:52.869355Z","steps":["trace[830158731] 'count revisions from in-memory index tree'  (duration: 375.992309ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:18:52.869401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:18:52.49305Z","time spent":"376.344288ms","remote":"127.0.0.1:59762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":31,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "}
{"level":"info","ts":"2026-09-07T18:19:20.49585Z","caller":"traceutil/trace.go:171","msg":"trace[1480456807] transaction","detail":"{read_only:false; response_revision:2323; number_of_response:1; }","duration":"125.171334ms","start":"2026-09-07T18:19:20.370614Z","end":"2026-09-07T18:19:20.495785Z","steps":["trace[1480456807] 'process raft request'  (duration: 124.961285ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:19:20.502068Z","caller":"traceutil/trace.go:171","msg":"trace[85760436] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"131.132137ms","start":"2026-09-07T18:19:20.3709Z","end":"2026-09-07T18:19:20.502033Z","steps":["trace[85760436] 'process raft request'  (duration: 130.911769ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:20:51.204963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.344585ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T18:20:51.205108Z","caller":"traceutil/trace.go:171","msg":"trace[2102715895] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2916; }","duration":"144.516688ms","start":"2026-09-07T18:20:51.06057Z","end":"2026-09-07T18:20:51.205087Z","steps":["trace[2102715895] 'range keys from in-memory index tree'  (duration: 144.320275ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:20:51.205545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.832061ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13701533900428778530 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2906 > 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:16"}
{"level":"info","ts":"2026-09-07T18:20:51.205717Z","caller":"traceutil/trace.go:171","msg":"trace[92439691] transaction","detail":"{read_only:false; response_revision:2917; number_of_response:1; }","duration":"251.841402ms","start":"2026-09-07T18:20:50.953855Z","end":"2026-09-07T18:20:51.205696Z","steps":["trace[92439691] 'process raft request'  (duration: 88.711966ms)","trace[92439691] 'compare'  (duration: 162.318198ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T18:20:51.205707Z","caller":"traceutil/trace.go:171","msg":"trace[404186601] linearizableReadLoop","detail":"{readStateIndex:3032; appliedIndex:3031; }","duration":"246.897658ms","start":"2026-09-07T18:20:50.958786Z","end":"2026-09-07T18:20:51.205683Z","steps":["trace[404186601] 'read index received'  (duration: 83.752331ms)","trace[404186601] 'applied index is now lower than readState.Index'  (duration: 163.143517ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T18:20:51.206075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.602892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-09-07T18:20:51.206134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.314806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-09-07T18:20:51.20628Z","caller":"traceutil/trace.go:171","msg":"trace[1552111772] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2917; }","duration":"247.45184ms","start":"2026-09-07T18:20:50.958756Z","end":"2026-09-07T18:20:51.206208Z","steps":["trace[1552111772] 'agreement among raft nodes before linearized reading'  (duration: 247.061992ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T18:20:51.20714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.06846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T18:20:51.207276Z","caller":"traceutil/trace.go:171","msg":"trace[1797545962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2917; }","duration":"188.277444ms","start":"2026-09-07T18:20:51.018973Z","end":"2026-09-07T18:20:51.20725Z","steps":["trace[1797545962] 'agreement among raft nodes before linearized reading'  (duration: 187.064348ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:20:51.206115Z","caller":"traceutil/trace.go:171","msg":"trace[1626295453] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2917; }","duration":"189.673922ms","start":"2026-09-07T18:20:51.016427Z","end":"2026-09-07T18:20:51.206101Z","steps":["trace[1626295453] 'agreement among raft nodes before linearized reading'  (duration: 189.433797ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:25:25.947868Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2781}
{"level":"info","ts":"2026-09-07T18:25:26.022776Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2781,"took":"73.75679ms","hash":1137690335,"current-db-size-bytes":51077120,"current-db-size":"51 MB","current-db-size-in-use-bytes":26615808,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-07T18:25:26.022837Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1137690335,"revision":2781,"compact-revision":-1}
{"level":"warn","ts":"2026-09-07T18:25:31.785102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.512431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-07T18:25:31.785207Z","caller":"traceutil/trace.go:171","msg":"trace[948500295] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5193; }","duration":"127.647647ms","start":"2026-09-07T18:25:31.657527Z","end":"2026-09-07T18:25:31.785175Z","steps":["trace[948500295] 'range keys from in-memory index tree'  (duration: 122.054125ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T18:30:25.960818Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5078}
{"level":"info","ts":"2026-09-07T18:30:26.036046Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5078,"took":"73.569644ms","hash":380217458,"current-db-size-bytes":51077120,"current-db-size":"51 MB","current-db-size-in-use-bytes":19685376,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-09-07T18:30:26.036099Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":380217458,"revision":5078,"compact-revision":2781}