{"level":"warn","ts":"2026-05-07T03:24:29.911777Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-07T03:24:29.911848Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.12: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.19.213.12:2380","--initial-cluster=instance=https://199.19.213.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.12:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-07T03:24:29.911908Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-07T03:24:29.91192Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.12:2380"]}
{"level":"info","ts":"2026-05-07T03:24:29.911937Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-07T03:24:29.912481Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"]}
{"level":"info","ts":"2026-05-07T03:24:29.912554Z","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.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.12:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-07T03:24:29.916178Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.423536ms"}
{"level":"info","ts":"2026-05-07T03:24:29.921713Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"790561176553eafe","cluster-id":"e32c72c573d8545f"}
{"level":"info","ts":"2026-05-07T03:24:29.921808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=()"}
{"level":"info","ts":"2026-05-07T03:24:29.922725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 0"}
{"level":"info","ts":"2026-05-07T03:24:29.922738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 790561176553eafe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-07T03:24:29.922749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 1"}
{"level":"info","ts":"2026-05-07T03:24:29.922798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"}
{"level":"warn","ts":"2026-05-07T03:24:29.937084Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-07T03:24:29.938915Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-07T03:24:29.941257Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-07T03:24:29.943269Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"790561176553eafe","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-07T03:24:29.943894Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"790561176553eafe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-07T03:24:29.94386Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-07T03:24:29.94426Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-07T03:24:29.944279Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-07T03:24:29.945238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"}
{"level":"info","ts":"2026-05-07T03:24:29.945438Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","added-peer-id":"790561176553eafe","added-peer-peer-urls":["https://199.19.213.12:2380"]}
{"level":"info","ts":"2026-05-07T03:24:29.948023Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-07T03:24:29.948302Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"790561176553eafe","initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-07T03:24:29.948334Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-07T03:24:29.948434Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.12:2380"}
{"level":"info","ts":"2026-05-07T03:24:29.948455Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.12:2380"}
{"level":"info","ts":"2026-05-07T03:24:30.223571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe is starting a new election at term 1"}
{"level":"info","ts":"2026-05-07T03:24:30.223685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-07T03:24:30.223716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgPreVoteResp from 790561176553eafe at term 1"}
{"level":"info","ts":"2026-05-07T03:24:30.22374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became candidate at term 2"}
{"level":"info","ts":"2026-05-07T03:24:30.223757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgVoteResp from 790561176553eafe at term 2"}
{"level":"info","ts":"2026-05-07T03:24:30.223779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became leader at term 2"}
{"level":"info","ts":"2026-05-07T03:24:30.2238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 790561176553eafe elected leader 790561176553eafe at term 2"}
{"level":"info","ts":"2026-05-07T03:24:30.224793Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"790561176553eafe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.12:2379]}","request-path":"/0/members/790561176553eafe/attributes","cluster-id":"e32c72c573d8545f","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-07T03:24:30.225204Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T03:24:30.225515Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-07T03:24:30.225566Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-07T03:24:30.225704Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-07T03:24:30.225801Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-07T03:24:30.227048Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T03:24:30.227145Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T03:24:30.227185Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T03:24:30.227401Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-07T03:24:30.229163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.12:2379"}
{"level":"info","ts":"2026-05-07T03:24:46.011037Z","caller":"traceutil/trace.go:171","msg":"trace[1453557217] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"192.072777ms","start":"2026-05-07T03:24:45.818942Z","end":"2026-05-07T03:24:46.011014Z","steps":["trace[1453557217] 'process raft request'  (duration: 191.925733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:24:46.318229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.361079ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:24:46.318422Z","caller":"traceutil/trace.go:171","msg":"trace[1521840225] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:409; }","duration":"285.574305ms","start":"2026-05-07T03:24:46.03282Z","end":"2026-05-07T03:24:46.318394Z","steps":["trace[1521840225] 'range keys from in-memory index tree'  (duration: 285.285617ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:24:46.318808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.889895ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933145373796033955 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:272 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-07T03:24:46.318931Z","caller":"traceutil/trace.go:171","msg":"trace[2073311018] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"271.622685ms","start":"2026-05-07T03:24:46.047286Z","end":"2026-05-07T03:24:46.318909Z","steps":["trace[2073311018] 'process raft request'  (duration: 42.100673ms)","trace[2073311018] 'compare'  (duration: 228.757901ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:24:46.502915Z","caller":"traceutil/trace.go:171","msg":"trace[1031204530] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"163.14492ms","start":"2026-05-07T03:24:46.339747Z","end":"2026-05-07T03:24:46.502892Z","steps":["trace[1031204530] 'read index received'  (duration: 162.821951ms)","trace[1031204530] 'applied index is now lower than readState.Index'  (duration: 321.989µs)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:24:46.502974Z","caller":"traceutil/trace.go:171","msg":"trace[333603407] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"170.537696ms","start":"2026-05-07T03:24:46.332412Z","end":"2026-05-07T03:24:46.50295Z","steps":["trace[333603407] 'process raft request'  (duration: 170.237777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:24:46.503081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.315825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4378"}
{"level":"info","ts":"2026-05-07T03:24:46.503116Z","caller":"traceutil/trace.go:171","msg":"trace[1603696792] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:411; }","duration":"163.382427ms","start":"2026-05-07T03:24:46.339723Z","end":"2026-05-07T03:24:46.503106Z","steps":["trace[1603696792] 'agreement among raft nodes before linearized reading'  (duration: 163.302865ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:24:46.503137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.077795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:24:46.503175Z","caller":"traceutil/trace.go:171","msg":"trace[639605144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"108.140486ms","start":"2026-05-07T03:24:46.395021Z","end":"2026-05-07T03:24:46.503161Z","steps":["trace[639605144] 'agreement among raft nodes before linearized reading'  (duration: 108.079544ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:00.653907Z","caller":"traceutil/trace.go:171","msg":"trace[401738103] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"100.72817ms","start":"2026-05-07T03:25:00.553163Z","end":"2026-05-07T03:25:00.653891Z","steps":["trace[401738103] 'process raft request'  (duration: 100.240957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:00.654479Z","caller":"traceutil/trace.go:171","msg":"trace[1182492951] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"101.114251ms","start":"2026-05-07T03:25:00.553281Z","end":"2026-05-07T03:25:00.654395Z","steps":["trace[1182492951] 'process raft request'  (duration: 100.224116ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:06.827338Z","caller":"traceutil/trace.go:171","msg":"trace[1451601949] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"165.960879ms","start":"2026-05-07T03:25:06.661349Z","end":"2026-05-07T03:25:06.82731Z","steps":["trace[1451601949] 'process raft request'  (duration: 130.825599ms)","trace[1451601949] 'compare'  (duration: 35.013597ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:25:06.827337Z","caller":"traceutil/trace.go:171","msg":"trace[1779949187] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"130.412138ms","start":"2026-05-07T03:25:06.696894Z","end":"2026-05-07T03:25:06.827306Z","steps":["trace[1779949187] 'read index received'  (duration: 95.258938ms)","trace[1779949187] 'applied index is now lower than readState.Index'  (duration: 35.15197ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:25:06.82755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.628674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-07T03:25:06.827663Z","caller":"traceutil/trace.go:171","msg":"trace[1525128817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"130.779017ms","start":"2026-05-07T03:25:06.696833Z","end":"2026-05-07T03:25:06.827612Z","steps":["trace[1525128817] 'agreement among raft nodes before linearized reading'  (duration: 130.529401ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:25:06.827573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.420408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-07T03:25:06.827801Z","caller":"traceutil/trace.go:171","msg":"trace[1555868147] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"130.667194ms","start":"2026-05-07T03:25:06.697091Z","end":"2026-05-07T03:25:06.827758Z","steps":["trace[1555868147] 'agreement among raft nodes before linearized reading'  (duration: 130.421918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:25:07.089968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.284216ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933145373796034330 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:602 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-07T03:25:07.090226Z","caller":"traceutil/trace.go:171","msg":"trace[1009005378] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:637; }","duration":"249.599351ms","start":"2026-05-07T03:25:06.840606Z","end":"2026-05-07T03:25:07.090206Z","steps":["trace[1009005378] 'read index received'  (duration: 106.090809ms)","trace[1009005378] 'applied index is now lower than readState.Index'  (duration: 143.507502ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:25:07.090327Z","caller":"traceutil/trace.go:171","msg":"trace[453427481] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"258.473469ms","start":"2026-05-07T03:25:06.831844Z","end":"2026-05-07T03:25:07.090317Z","steps":["trace[453427481] 'process raft request'  (duration: 258.247522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:25:07.090411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.792467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:25:07.090525Z","caller":"traceutil/trace.go:171","msg":"trace[1404431511] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:620; }","duration":"249.925362ms","start":"2026-05-07T03:25:06.840577Z","end":"2026-05-07T03:25:07.090502Z","steps":["trace[1404431511] 'agreement among raft nodes before linearized reading'  (duration: 249.780468ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:07.090574Z","caller":"traceutil/trace.go:171","msg":"trace[254568961] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"259.164328ms","start":"2026-05-07T03:25:06.831357Z","end":"2026-05-07T03:25:07.090522Z","steps":["trace[254568961] 'process raft request'  (duration: 115.226223ms)","trace[254568961] 'compare'  (duration: 143.115041ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:25:07.090653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.370976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-542qt\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-07T03:25:07.091044Z","caller":"traceutil/trace.go:171","msg":"trace[735603401] range","detail":"{range_begin:/registry/pods/kube-system/cilium-542qt; range_end:; response_count:1; response_revision:620; }","duration":"225.731226ms","start":"2026-05-07T03:25:06.86527Z","end":"2026-05-07T03:25:07.091001Z","steps":["trace[735603401] 'agreement among raft nodes before linearized reading'  (duration: 225.274404ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:07.090738Z","caller":"traceutil/trace.go:171","msg":"trace[722616000] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"258.741097ms","start":"2026-05-07T03:25:06.83193Z","end":"2026-05-07T03:25:07.090671Z","steps":["trace[722616000] 'process raft request'  (duration: 258.235912ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:25:07.525787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.680774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:25:07.525879Z","caller":"traceutil/trace.go:171","msg":"trace[40120529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"130.781547ms","start":"2026-05-07T03:25:07.395076Z","end":"2026-05-07T03:25:07.525858Z","steps":["trace[40120529] 'range keys from in-memory index tree'  (duration: 130.583052ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:07.614827Z","caller":"traceutil/trace.go:171","msg":"trace[1995261973] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"136.192709ms","start":"2026-05-07T03:25:07.47861Z","end":"2026-05-07T03:25:07.614803Z","steps":["trace[1995261973] 'process raft request'  (duration: 135.677875ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:25:09.095425Z","caller":"traceutil/trace.go:171","msg":"trace[684699659] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"106.972273ms","start":"2026-05-07T03:25:08.988436Z","end":"2026-05-07T03:25:09.095409Z","steps":["trace[684699659] 'process raft request'  (duration: 106.818959ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:25:22.518427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.537825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:25:22.518543Z","caller":"traceutil/trace.go:171","msg":"trace[2079383903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"122.734431ms","start":"2026-05-07T03:25:22.395787Z","end":"2026-05-07T03:25:22.518521Z","steps":["trace[2079383903] 'range keys from in-memory index tree'  (duration: 122.434993ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:05.23889Z","caller":"traceutil/trace.go:171","msg":"trace[1128735945] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"110.799448ms","start":"2026-05-07T03:26:05.128063Z","end":"2026-05-07T03:26:05.238862Z","steps":["trace[1128735945] 'process raft request'  (duration: 110.647814ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:05.279813Z","caller":"traceutil/trace.go:171","msg":"trace[949024237] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1345; }","duration":"103.189313ms","start":"2026-05-07T03:26:05.176593Z","end":"2026-05-07T03:26:05.279782Z","steps":["trace[949024237] 'read index received'  (duration: 62.135767ms)","trace[949024237] 'applied index is now lower than readState.Index'  (duration: 41.052496ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:26:05.280061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.450491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-d2j2v\" ","response":"range_response_count:1 size:4196"}
{"level":"info","ts":"2026-05-07T03:26:05.280119Z","caller":"traceutil/trace.go:171","msg":"trace[1085023624] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-d2j2v; range_end:; response_count:1; response_revision:1308; }","duration":"103.554084ms","start":"2026-05-07T03:26:05.176548Z","end":"2026-05-07T03:26:05.280102Z","steps":["trace[1085023624] 'agreement among raft nodes before linearized reading'  (duration: 103.345019ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:05.280086Z","caller":"traceutil/trace.go:171","msg":"trace[1569674376] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"105.400735ms","start":"2026-05-07T03:26:05.174648Z","end":"2026-05-07T03:26:05.280048Z","steps":["trace[1569674376] 'process raft request'  (duration: 90.462938ms)","trace[1569674376] 'compare'  (duration: 14.552596ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:35.75815Z","caller":"traceutil/trace.go:171","msg":"trace[1313608036] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1894; }","duration":"394.63709ms","start":"2026-05-07T03:26:35.363487Z","end":"2026-05-07T03:26:35.758124Z","steps":["trace[1313608036] 'read index received'  (duration: 394.475716ms)","trace[1313608036] 'applied index is now lower than readState.Index'  (duration: 160.544µs)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:35.758243Z","caller":"traceutil/trace.go:171","msg":"trace[1429973792] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"427.783067ms","start":"2026-05-07T03:26:35.330422Z","end":"2026-05-07T03:26:35.758205Z","steps":["trace[1429973792] 'process raft request'  (duration: 427.550641ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.758355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.828246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-07T03:26:35.758438Z","caller":"traceutil/trace.go:171","msg":"trace[748945053] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1827; }","duration":"394.939469ms","start":"2026-05-07T03:26:35.363482Z","end":"2026-05-07T03:26:35.758421Z","steps":["trace[748945053] 'agreement among raft nodes before linearized reading'  (duration: 394.756204ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.758417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.330404Z","time spent":"427.922001ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c7adace0-211d-42c0-9ab3-fe51cf5aec03\" mod_revision:1790 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c7adace0-211d-42c0-9ab3-fe51cf5aec03\" value_size:3628 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c7adace0-211d-42c0-9ab3-fe51cf5aec03\" > >"}
{"level":"warn","ts":"2026-05-07T03:26:35.758488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.363427Z","time spent":"395.051132ms","remote":"127.0.0.1:34808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":36,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"info","ts":"2026-05-07T03:26:35.949678Z","caller":"traceutil/trace.go:171","msg":"trace[2129731009] linearizableReadLoop","detail":"{readStateIndex:1896; appliedIndex:1895; }","duration":"191.44025ms","start":"2026-05-07T03:26:35.758216Z","end":"2026-05-07T03:26:35.949656Z","steps":["trace[2129731009] 'read index received'  (duration: 191.251145ms)","trace[2129731009] 'applied index is now lower than readState.Index'  (duration: 188.495µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:26:35.949872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.370413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-07T03:26:35.9499Z","caller":"traceutil/trace.go:171","msg":"trace[1249600798] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1828; }","duration":"418.451226ms","start":"2026-05-07T03:26:35.531441Z","end":"2026-05-07T03:26:35.949892Z","steps":["trace[1249600798] 'agreement among raft nodes before linearized reading'  (duration: 418.324942ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.949876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.942723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c7adace0-211d-42c0-9ab3-fe51cf5aec03\" ","response":"range_response_count:1 size:3743"}
{"level":"warn","ts":"2026-05-07T03:26:35.949964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.35155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-05-07T03:26:35.949967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.209562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-07T03:26:35.950045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.632998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:26:35.950086Z","caller":"traceutil/trace.go:171","msg":"trace[1714022993] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1828; }","duration":"343.361596ms","start":"2026-05-07T03:26:35.606704Z","end":"2026-05-07T03:26:35.950066Z","steps":["trace[1714022993] 'agreement among raft nodes before linearized reading'  (duration: 343.202972ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:35.950114Z","caller":"traceutil/trace.go:171","msg":"trace[999010413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1828; }","duration":"556.762141ms","start":"2026-05-07T03:26:35.393337Z","end":"2026-05-07T03:26:35.950099Z","steps":["trace[999010413] 'agreement among raft nodes before linearized reading'  (duration: 556.643178ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.950145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.393321Z","time spent":"556.818702ms","remote":"127.0.0.1:34300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-07T03:26:35.949927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.531422Z","time spent":"418.499727ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-07T03:26:35.950159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.275188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-05-07T03:26:35.950187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.557842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-07T03:26:35.950229Z","caller":"traceutil/trace.go:171","msg":"trace[1988825891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1828; }","duration":"424.386131ms","start":"2026-05-07T03:26:35.525827Z","end":"2026-05-07T03:26:35.950213Z","steps":["trace[1988825891] 'agreement among raft nodes before linearized reading'  (duration: 424.196936ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:35.950243Z","caller":"traceutil/trace.go:171","msg":"trace[1090482611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1828; }","duration":"548.662355ms","start":"2026-05-07T03:26:35.401573Z","end":"2026-05-07T03:26:35.950236Z","steps":["trace[1090482611] 'agreement among raft nodes before linearized reading'  (duration: 548.46633ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.950276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.525809Z","time spent":"424.455004ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-07T03:26:35.95002Z","caller":"traceutil/trace.go:171","msg":"trace[1087222235] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1828; }","duration":"239.491004ms","start":"2026-05-07T03:26:35.710517Z","end":"2026-05-07T03:26:35.950008Z","steps":["trace[1087222235] 'agreement among raft nodes before linearized reading'  (duration: 239.313009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:35.95013Z","caller":"traceutil/trace.go:171","msg":"trace[1998574577] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c7adace0-211d-42c0-9ab3-fe51cf5aec03; range_end:; response_count:1; response_revision:1828; }","duration":"417.071617ms","start":"2026-05-07T03:26:35.532886Z","end":"2026-05-07T03:26:35.949957Z","steps":["trace[1998574577] 'agreement among raft nodes before linearized reading'  (duration: 416.79395ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.950297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.401551Z","time spent":"548.737817ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-07T03:26:35.950351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.532879Z","time spent":"417.457029ms","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c7adace0-211d-42c0-9ab3-fe51cf5aec03\" "}
{"level":"warn","ts":"2026-05-07T03:26:35.949982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.932549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-07T03:26:35.950168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.606657Z","time spent":"343.490051ms","remote":"127.0.0.1:34754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":2,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-05-07T03:26:35.950408Z","caller":"traceutil/trace.go:171","msg":"trace[1953691799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1828; }","duration":"424.360091ms","start":"2026-05-07T03:26:35.526031Z","end":"2026-05-07T03:26:35.950391Z","steps":["trace[1953691799] 'agreement among raft nodes before linearized reading'  (duration: 423.909498ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.950561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.526024Z","time spent":"424.520017ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-07T03:26:35.950042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.55424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"}
{"level":"info","ts":"2026-05-07T03:26:35.950733Z","caller":"traceutil/trace.go:171","msg":"trace[1011822776] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1828; }","duration":"189.26193ms","start":"2026-05-07T03:26:35.761453Z","end":"2026-05-07T03:26:35.950715Z","steps":["trace[1011822776] 'agreement among raft nodes before linearized reading'  (duration: 188.5452ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:35.950793Z","caller":"traceutil/trace.go:171","msg":"trace[1774395111] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"563.730937ms","start":"2026-05-07T03:26:35.385981Z","end":"2026-05-07T03:26:35.949712Z","steps":["trace[1774395111] 'process raft request'  (duration: 563.541741ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:35.951113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:26:35.385954Z","time spent":"564.999383ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1768 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-07T03:26:36.141508Z","caller":"traceutil/trace.go:171","msg":"trace[1971672870] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"186.528704ms","start":"2026-05-07T03:26:35.954947Z","end":"2026-05-07T03:26:36.141475Z","steps":["trace[1971672870] 'process raft request'  (duration: 120.881879ms)","trace[1971672870] 'compare'  (duration: 65.234014ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:36.141544Z","caller":"traceutil/trace.go:171","msg":"trace[190486125] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1897; }","duration":"125.059985ms","start":"2026-05-07T03:26:36.016461Z","end":"2026-05-07T03:26:36.141521Z","steps":["trace[190486125] 'read index received'  (duration: 59.335118ms)","trace[190486125] 'applied index is now lower than readState.Index'  (duration: 65.723677ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:36.141675Z","caller":"traceutil/trace.go:171","msg":"trace[533661062] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"186.602096ms","start":"2026-05-07T03:26:35.955055Z","end":"2026-05-07T03:26:36.141657Z","steps":["trace[533661062] 'process raft request'  (duration: 186.261907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:36.141728Z","caller":"traceutil/trace.go:171","msg":"trace[1520384269] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"181.561125ms","start":"2026-05-07T03:26:35.96015Z","end":"2026-05-07T03:26:36.141711Z","steps":["trace[1520384269] 'process raft request'  (duration: 181.291577ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:36.141856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.378145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:26:36.141872Z","caller":"traceutil/trace.go:171","msg":"trace[304655266] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"186.73193ms","start":"2026-05-07T03:26:35.955093Z","end":"2026-05-07T03:26:36.141824Z","steps":["trace[304655266] 'process raft request'  (duration: 186.301318ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:36.141938Z","caller":"traceutil/trace.go:171","msg":"trace[313972846] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1833; }","duration":"125.510328ms","start":"2026-05-07T03:26:36.016404Z","end":"2026-05-07T03:26:36.141915Z","steps":["trace[313972846] 'agreement among raft nodes before linearized reading'  (duration: 125.365784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:36.142011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.897674ms","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-05-07T03:26:36.142101Z","caller":"traceutil/trace.go:171","msg":"trace[1339525666] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1833; }","duration":"104.037488ms","start":"2026-05-07T03:26:36.038048Z","end":"2026-05-07T03:26:36.142086Z","steps":["trace[1339525666] 'agreement among raft nodes before linearized reading'  (duration: 103.74564ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:36.395201Z","caller":"traceutil/trace.go:171","msg":"trace[1417330614] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"247.633141ms","start":"2026-05-07T03:26:36.147538Z","end":"2026-05-07T03:26:36.395171Z","steps":["trace[1417330614] 'process raft request'  (duration: 197.383976ms)","trace[1417330614] 'compare'  (duration: 49.963377ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:36.395312Z","caller":"traceutil/trace.go:171","msg":"trace[302923249] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1901; }","duration":"230.983105ms","start":"2026-05-07T03:26:36.164318Z","end":"2026-05-07T03:26:36.395301Z","steps":["trace[302923249] 'read index received'  (duration: 396.551µs)","trace[302923249] 'applied index is now lower than readState.Index'  (duration: 230.584764ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:36.395522Z","caller":"traceutil/trace.go:171","msg":"trace[1161870559] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"246.608013ms","start":"2026-05-07T03:26:36.148856Z","end":"2026-05-07T03:26:36.395464Z","steps":["trace[1161870559] 'process raft request'  (duration: 246.411868ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:36.395713Z","caller":"traceutil/trace.go:171","msg":"trace[437143708] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"247.134487ms","start":"2026-05-07T03:26:36.148563Z","end":"2026-05-07T03:26:36.395697Z","steps":["trace[437143708] 'process raft request'  (duration: 246.667565ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:36.395577Z","caller":"traceutil/trace.go:171","msg":"trace[1308818927] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"247.275601ms","start":"2026-05-07T03:26:36.148268Z","end":"2026-05-07T03:26:36.395543Z","steps":["trace[1308818927] 'process raft request'  (duration: 246.705895ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:36.396186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.851281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-07T03:26:36.396254Z","caller":"traceutil/trace.go:171","msg":"trace[355975113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1838; }","duration":"231.968024ms","start":"2026-05-07T03:26:36.164269Z","end":"2026-05-07T03:26:36.396237Z","steps":["trace[355975113] 'agreement among raft nodes before linearized reading'  (duration: 231.304765ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:36.415687Z","caller":"traceutil/trace.go:171","msg":"trace[1635215233] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"181.254527ms","start":"2026-05-07T03:26:36.234409Z","end":"2026-05-07T03:26:36.415664Z","steps":["trace[1635215233] 'process raft request'  (duration: 181.105313ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:48.437328Z","caller":"traceutil/trace.go:171","msg":"trace[782326316] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"236.622064ms","start":"2026-05-07T03:26:48.200682Z","end":"2026-05-07T03:26:48.437305Z","steps":["trace[782326316] 'process raft request'  (duration: 235.441401ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:26:48.437459Z","caller":"traceutil/trace.go:171","msg":"trace[1589477528] linearizableReadLoop","detail":"{readStateIndex:2010; appliedIndex:2007; }","duration":"219.778412ms","start":"2026-05-07T03:26:48.217654Z","end":"2026-05-07T03:26:48.437432Z","steps":["trace[1589477528] 'read index received'  (duration: 30.77672ms)","trace[1589477528] 'applied index is now lower than readState.Index'  (duration: 189.000302ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:26:48.437644Z","caller":"traceutil/trace.go:171","msg":"trace[2105167141] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"235.562894ms","start":"2026-05-07T03:26:48.202066Z","end":"2026-05-07T03:26:48.437629Z","steps":["trace[2105167141] 'process raft request'  (duration: 235.164783ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:26:48.437945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.264286ms","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-05-07T03:26:48.43802Z","caller":"traceutil/trace.go:171","msg":"trace[1866265132] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1940; }","duration":"220.372269ms","start":"2026-05-07T03:26:48.217627Z","end":"2026-05-07T03:26:48.437999Z","steps":["trace[1866265132] 'agreement among raft nodes before linearized reading'  (duration: 220.04109ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:27:24.81985Z","caller":"traceutil/trace.go:171","msg":"trace[773844311] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2225; }","duration":"112.684634ms","start":"2026-05-07T03:27:24.707143Z","end":"2026-05-07T03:27:24.819828Z","steps":["trace[773844311] 'read index received'  (duration: 61.184142ms)","trace[773844311] 'applied index is now lower than readState.Index'  (duration: 51.499292ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:27:24.820129Z","caller":"traceutil/trace.go:171","msg":"trace[93551525] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"185.429308ms","start":"2026-05-07T03:27:24.634668Z","end":"2026-05-07T03:27:24.820097Z","steps":["trace[93551525] 'process raft request'  (duration: 133.610587ms)","trace[93551525] 'compare'  (duration: 51.42116ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:27:24.820249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.090945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-07T03:27:24.820345Z","caller":"traceutil/trace.go:171","msg":"trace[947725492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2148; }","duration":"113.231119ms","start":"2026-05-07T03:27:24.707103Z","end":"2026-05-07T03:27:24.820334Z","steps":["trace[947725492] 'agreement among raft nodes before linearized reading'  (duration: 113.023984ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:27:31.017763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.556552ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933145373796037557 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2168 > 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-05-07T03:27:31.017873Z","caller":"traceutil/trace.go:171","msg":"trace[265785223] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"328.125428ms","start":"2026-05-07T03:27:30.689729Z","end":"2026-05-07T03:27:31.017855Z","steps":["trace[265785223] 'process raft request'  (duration: 87.401801ms)","trace[265785223] 'compare'  (duration: 240.440129ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:27:31.01792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:27:30.689712Z","time spent":"328.186439ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2168 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-07T03:27:31.031543Z","caller":"traceutil/trace.go:171","msg":"trace[1080060377] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2256; }","duration":"328.90461ms","start":"2026-05-07T03:27:30.702614Z","end":"2026-05-07T03:27:31.031519Z","steps":["trace[1080060377] 'read index received'  (duration: 74.499703ms)","trace[1080060377] 'applied index is now lower than readState.Index'  (duration: 254.403777ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:27:31.031666Z","caller":"traceutil/trace.go:171","msg":"trace[1328158812] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"341.817848ms","start":"2026-05-07T03:27:30.689784Z","end":"2026-05-07T03:27:31.031602Z","steps":["trace[1328158812] 'process raft request'  (duration: 341.594482ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:27:31.031713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.072345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:27:31.03178Z","caller":"traceutil/trace.go:171","msg":"trace[1559066412] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2179; }","duration":"329.195038ms","start":"2026-05-07T03:27:30.702565Z","end":"2026-05-07T03:27:31.03176Z","steps":["trace[1559066412] 'agreement among raft nodes before linearized reading'  (duration: 329.058404ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:27:31.03182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:27:30.702546Z","time spent":"329.26616ms","remote":"127.0.0.1:37470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "}
{"level":"warn","ts":"2026-05-07T03:27:31.031839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:27:30.689758Z","time spent":"341.995604ms","remote":"127.0.0.1:34582","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:2169 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-07T03:27:31.285464Z","caller":"traceutil/trace.go:171","msg":"trace[1896106850] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"253.81756ms","start":"2026-05-07T03:27:31.031616Z","end":"2026-05-07T03:27:31.285433Z","steps":["trace[1896106850] 'read index received'  (duration: 173.957738ms)","trace[1896106850] 'applied index is now lower than readState.Index'  (duration: 79.857802ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:27:31.285594Z","caller":"traceutil/trace.go:171","msg":"trace[2104961578] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"472.096912ms","start":"2026-05-07T03:27:30.813344Z","end":"2026-05-07T03:27:31.285441Z","steps":["trace[2104961578] 'process raft request'  (duration: 392.265501ms)","trace[2104961578] 'compare'  (duration: 79.621755ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:27:31.285661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.696863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-07T03:27:31.285703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:27:30.813277Z","time spent":"472.362599ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2139 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-07T03:27:31.285705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.035652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-07T03:27:31.285742Z","caller":"traceutil/trace.go:171","msg":"trace[1051468140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2180; }","duration":"429.832317ms","start":"2026-05-07T03:27:30.855892Z","end":"2026-05-07T03:27:31.285724Z","steps":["trace[1051468140] 'agreement among raft nodes before linearized reading'  (duration: 429.571779ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:27:31.285757Z","caller":"traceutil/trace.go:171","msg":"trace[1679052437] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2180; }","duration":"439.137775ms","start":"2026-05-07T03:27:30.846604Z","end":"2026-05-07T03:27:31.285741Z","steps":["trace[1679052437] 'agreement among raft nodes before linearized reading'  (duration: 438.96393ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:27:31.285799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:27:30.855873Z","time spent":"429.915428ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-07T03:27:31.285802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:27:30.846582Z","time spent":"439.209026ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-07T03:27:31.361097Z","caller":"traceutil/trace.go:171","msg":"trace[1691687857] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"230.616715ms","start":"2026-05-07T03:27:31.130456Z","end":"2026-05-07T03:27:31.361072Z","steps":["trace[1691687857] 'process raft request'  (duration: 230.45205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:27:31.408643Z","caller":"traceutil/trace.go:171","msg":"trace[1664356941] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"118.398033ms","start":"2026-05-07T03:27:31.290215Z","end":"2026-05-07T03:27:31.408613Z","steps":["trace[1664356941] 'process raft request'  (duration: 105.752172ms)","trace[1664356941] 'compare'  (duration: 12.467426ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:27:31.408854Z","caller":"traceutil/trace.go:171","msg":"trace[1539244273] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"118.451515ms","start":"2026-05-07T03:27:31.290374Z","end":"2026-05-07T03:27:31.408826Z","steps":["trace[1539244273] 'process raft request'  (duration: 118.197648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:28:40.064649Z","caller":"traceutil/trace.go:171","msg":"trace[1687653310] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"111.804768ms","start":"2026-05-07T03:28:39.95281Z","end":"2026-05-07T03:28:40.064615Z","steps":["trace[1687653310] 'process raft request'  (duration: 73.01858ms)","trace[1687653310] 'compare'  (duration: 38.657064ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:28:46.015616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.390849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-07T03:28:46.015729Z","caller":"traceutil/trace.go:171","msg":"trace[1396010849] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2781; }","duration":"105.535473ms","start":"2026-05-07T03:28:45.910173Z","end":"2026-05-07T03:28:46.015708Z","steps":["trace[1396010849] 'range keys from in-memory index tree'  (duration: 105.257205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:31:06.237933Z","caller":"traceutil/trace.go:171","msg":"trace[564539181] linearizableReadLoop","detail":"{readStateIndex:3855; appliedIndex:3854; }","duration":"200.674081ms","start":"2026-05-07T03:31:06.037231Z","end":"2026-05-07T03:31:06.237905Z","steps":["trace[564539181] 'read index received'  (duration: 200.520387ms)","trace[564539181] 'applied index is now lower than readState.Index'  (duration: 151.934µs)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:31:06.238026Z","caller":"traceutil/trace.go:171","msg":"trace[2096925694] transaction","detail":"{read_only:false; response_revision:3718; number_of_response:1; }","duration":"224.477487ms","start":"2026-05-07T03:31:06.01352Z","end":"2026-05-07T03:31:06.237997Z","steps":["trace[2096925694] 'process raft request'  (duration: 224.194799ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:31:06.238199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.948878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-07T03:31:06.238244Z","caller":"traceutil/trace.go:171","msg":"trace[889449056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3718; }","duration":"201.033691ms","start":"2026-05-07T03:31:06.037205Z","end":"2026-05-07T03:31:06.238239Z","steps":["trace[889449056] 'agreement among raft nodes before linearized reading'  (duration: 200.875607ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:31:06.238995Z","caller":"traceutil/trace.go:171","msg":"trace[1591608941] transaction","detail":"{read_only:false; response_revision:3719; number_of_response:1; }","duration":"183.744527ms","start":"2026-05-07T03:31:06.055213Z","end":"2026-05-07T03:31:06.238957Z","steps":["trace[1591608941] 'process raft request'  (duration: 183.544661ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:32:23.769764Z","caller":"traceutil/trace.go:171","msg":"trace[1380049906] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"109.70693ms","start":"2026-05-07T03:32:23.660025Z","end":"2026-05-07T03:32:23.769732Z","steps":["trace[1380049906] 'process raft request'  (duration: 53.448441ms)","trace[1380049906] 'compare'  (duration: 55.871089ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:32:31.102601Z","caller":"traceutil/trace.go:171","msg":"trace[392421342] linearizableReadLoop","detail":"{readStateIndex:5096; appliedIndex:5095; }","duration":"115.777722ms","start":"2026-05-07T03:32:30.986797Z","end":"2026-05-07T03:32:31.102575Z","steps":["trace[392421342] 'read index received'  (duration: 115.601337ms)","trace[392421342] 'applied index is now lower than readState.Index'  (duration: 175.295µs)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:32:31.102828Z","caller":"traceutil/trace.go:171","msg":"trace[809172537] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"191.26228ms","start":"2026-05-07T03:32:30.911368Z","end":"2026-05-07T03:32:31.10263Z","steps":["trace[809172537] 'process raft request'  (duration: 191.045694ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:32:31.102856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.046819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d9662d1a-cdb9-40d7-8403-ed7e213d0eaa\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-05-07T03:32:31.102907Z","caller":"traceutil/trace.go:171","msg":"trace[1154066811] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d9662d1a-cdb9-40d7-8403-ed7e213d0eaa; range_end:; response_count:1; response_revision:4912; }","duration":"116.154162ms","start":"2026-05-07T03:32:30.986742Z","end":"2026-05-07T03:32:31.102896Z","steps":["trace[1154066811] 'agreement among raft nodes before linearized reading'  (duration: 115.973327ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:32:31.194632Z","caller":"traceutil/trace.go:171","msg":"trace[153825767] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"140.684931ms","start":"2026-05-07T03:32:31.053917Z","end":"2026-05-07T03:32:31.194602Z","steps":["trace[153825767] 'process raft request'  (duration: 140.541847ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:32:31.194704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.471111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d9662d1a-cdb9-40d7-8403-ed7e213d0eaa\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-05-07T03:32:31.194756Z","caller":"traceutil/trace.go:171","msg":"trace[79422688] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d9662d1a-cdb9-40d7-8403-ed7e213d0eaa; range_end:; response_count:1; response_revision:4913; }","duration":"147.535483ms","start":"2026-05-07T03:32:31.047208Z","end":"2026-05-07T03:32:31.194744Z","steps":["trace[79422688] 'agreement among raft nodes before linearized reading'  (duration: 147.363138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:32:41.530758Z","caller":"traceutil/trace.go:171","msg":"trace[726766708] linearizableReadLoop","detail":"{readStateIndex:5303; appliedIndex:5302; }","duration":"135.111703ms","start":"2026-05-07T03:32:41.395616Z","end":"2026-05-07T03:32:41.530728Z","steps":["trace[726766708] 'read index received'  (duration: 134.895437ms)","trace[726766708] 'applied index is now lower than readState.Index'  (duration: 215.016µs)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:32:41.530812Z","caller":"traceutil/trace.go:171","msg":"trace[1960321743] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"166.821524ms","start":"2026-05-07T03:32:41.363956Z","end":"2026-05-07T03:32:41.530778Z","steps":["trace[1960321743] 'process raft request'  (duration: 166.542066ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:32:41.530907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.271518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T03:32:41.530956Z","caller":"traceutil/trace.go:171","msg":"trace[1336353997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5114; }","duration":"135.372511ms","start":"2026-05-07T03:32:41.395571Z","end":"2026-05-07T03:32:41.530944Z","steps":["trace[1336353997] 'agreement among raft nodes before linearized reading'  (duration: 135.251128ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:32:49.519705Z","caller":"traceutil/trace.go:171","msg":"trace[1897498817] linearizableReadLoop","detail":"{readStateIndex:5457; appliedIndex:5456; }","duration":"159.83133ms","start":"2026-05-07T03:32:49.359842Z","end":"2026-05-07T03:32:49.519673Z","steps":["trace[1897498817] 'read index received'  (duration: 148.881243ms)","trace[1897498817] 'applied index is now lower than readState.Index'  (duration: 10.947977ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T03:32:49.519836Z","caller":"traceutil/trace.go:171","msg":"trace[1139169627] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"214.62223ms","start":"2026-05-07T03:32:49.305182Z","end":"2026-05-07T03:32:49.519804Z","steps":["trace[1139169627] 'process raft request'  (duration: 203.638081ms)","trace[1139169627] 'compare'  (duration: 10.67313ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T03:32:49.519944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.081827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-07T03:32:49.519994Z","caller":"traceutil/trace.go:171","msg":"trace[758469767] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5266; }","duration":"160.145479ms","start":"2026-05-07T03:32:49.359835Z","end":"2026-05-07T03:32:49.519981Z","steps":["trace[758469767] 'agreement among raft nodes before linearized reading'  (duration: 159.971664ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T03:32:49.734836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.240742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dx4t5\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-05-07T03:32:49.734939Z","caller":"traceutil/trace.go:171","msg":"trace[882084862] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dx4t5; range_end:; response_count:1; response_revision:5267; }","duration":"107.390976ms","start":"2026-05-07T03:32:49.627521Z","end":"2026-05-07T03:32:49.734912Z","steps":["trace[882084862] 'range keys from in-memory index tree'  (duration: 107.040696ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T03:34:30.950724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3026}
{"level":"info","ts":"2026-05-07T03:34:31.037617Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3026,"took":"85.387668ms","hash":4067982946,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":32292864,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-07T03:34:31.037657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4067982946,"revision":3026,"compact-revision":-1}
{"level":"info","ts":"2026-05-07T03:39:30.994261Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6184}
{"level":"info","ts":"2026-05-07T03:39:31.107808Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6184,"took":"111.560756ms","hash":2368601851,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":17604608,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-07T03:39:31.107888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2368601851,"revision":6184,"compact-revision":3026}