{"level":"warn","ts":"2026-08-12T17:30:31.687893Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-12T17:30:31.687997Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.136: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.136:2380","--initial-cluster=instance=https://199.19.213.136:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.136:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.136: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-08-12T17:30:31.688077Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-12T17:30:31.688098Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.136:2380"]}
{"level":"info","ts":"2026-08-12T17:30:31.688126Z","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-08-12T17:30:31.688931Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"]}
{"level":"info","ts":"2026-08-12T17:30:31.689022Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.136: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-08-12T17:30:31.692528Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.272327ms"}
{"level":"info","ts":"2026-08-12T17:30:31.697114Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bcbe0b88c51dc5e5","cluster-id":"e591ddd6f6a32da9"}
{"level":"info","ts":"2026-08-12T17:30:31.697208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-12T17:30:31.697244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 0"}
{"level":"info","ts":"2026-08-12T17:30:31.697274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bcbe0b88c51dc5e5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-12T17:30:31.697305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 1"}
{"level":"info","ts":"2026-08-12T17:30:31.697356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"}
{"level":"warn","ts":"2026-08-12T17:30:31.705153Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-12T17:30:31.707012Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-12T17:30:31.70848Z","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-08-12T17:30:31.713767Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bcbe0b88c51dc5e5","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-12T17:30:31.714021Z","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-08-12T17:30:31.714066Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bcbe0b88c51dc5e5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-12T17:30:31.714113Z","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-08-12T17:30:31.714141Z","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-08-12T17:30:31.714708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"}
{"level":"info","ts":"2026-08-12T17:30:31.71483Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","added-peer-id":"bcbe0b88c51dc5e5","added-peer-peer-urls":["https://199.19.213.136:2380"]}
{"level":"info","ts":"2026-08-12T17:30:31.720585Z","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-08-12T17:30:31.720718Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.136:2380"}
{"level":"info","ts":"2026-08-12T17:30:31.72077Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.136:2380"}
{"level":"info","ts":"2026-08-12T17:30:31.72126Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bcbe0b88c51dc5e5","initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-12T17:30:31.721314Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-12T17:30:31.997854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-12T17:30:31.997905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-12T17:30:31.997923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgPreVoteResp from bcbe0b88c51dc5e5 at term 1"}
{"level":"info","ts":"2026-08-12T17:30:31.997937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became candidate at term 2"}
{"level":"info","ts":"2026-08-12T17:30:31.997944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgVoteResp from bcbe0b88c51dc5e5 at term 2"}
{"level":"info","ts":"2026-08-12T17:30:31.997954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became leader at term 2"}
{"level":"info","ts":"2026-08-12T17:30:31.997964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bcbe0b88c51dc5e5 elected leader bcbe0b88c51dc5e5 at term 2"}
{"level":"info","ts":"2026-08-12T17:30:32.132572Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-12T17:30:32.240761Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bcbe0b88c51dc5e5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.136:2379]}","request-path":"/0/members/bcbe0b88c51dc5e5/attributes","cluster-id":"e591ddd6f6a32da9","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-12T17:30:32.240777Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-12T17:30:32.240821Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-12T17:30:32.24141Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-12T17:30:32.241464Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-12T17:30:32.243724Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.136:2379"}
{"level":"info","ts":"2026-08-12T17:30:32.247014Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-12T17:30:32.279994Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-12T17:30:32.280146Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-12T17:30:32.280175Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-08-12T17:30:32.503277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.05229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.503419Z","caller":"traceutil/trace.go:171","msg":"trace[626040109] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"187.195011ms","start":"2026-08-12T17:30:32.316207Z","end":"2026-08-12T17:30:32.503402Z","steps":["trace[626040109] 'range keys from in-memory index tree'  (duration: 186.958283ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:30:32.50357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.276686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.50362Z","caller":"traceutil/trace.go:171","msg":"trace[1357924718] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"187.348362ms","start":"2026-08-12T17:30:32.316265Z","end":"2026-08-12T17:30:32.503613Z","steps":["trace[1357924718] 'count revisions from in-memory index tree'  (duration: 187.245294ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:30:32.503746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.335111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.503796Z","caller":"traceutil/trace.go:171","msg":"trace[1331218487] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"141.409117ms","start":"2026-08-12T17:30:32.36238Z","end":"2026-08-12T17:30:32.503789Z","steps":["trace[1331218487] 'count revisions from in-memory index tree'  (duration: 141.274457ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:30:32.503938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.555705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.503986Z","caller":"traceutil/trace.go:171","msg":"trace[342893248] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"128.640721ms","start":"2026-08-12T17:30:32.375339Z","end":"2026-08-12T17:30:32.503979Z","steps":["trace[342893248] 'range keys from in-memory index tree'  (duration: 128.491089ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:30:32.504122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.615669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.504167Z","caller":"traceutil/trace.go:171","msg":"trace[1526693221] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"128.701815ms","start":"2026-08-12T17:30:32.375459Z","end":"2026-08-12T17:30:32.504161Z","steps":["trace[1526693221] 'count revisions from in-memory index tree'  (duration: 128.535173ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:30:32.504595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.771612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.504658Z","caller":"traceutil/trace.go:171","msg":"trace[134989709] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"107.851498ms","start":"2026-08-12T17:30:32.396791Z","end":"2026-08-12T17:30:32.504643Z","steps":["trace[134989709] 'range keys from in-memory index tree'  (duration: 107.720299ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:30:32.504816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.811075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-12T17:30:32.504873Z","caller":"traceutil/trace.go:171","msg":"trace[198421583] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"107.87193ms","start":"2026-08-12T17:30:32.396987Z","end":"2026-08-12T17:30:32.504858Z","steps":["trace[198421583] 'count revisions from in-memory index tree'  (duration: 107.752861ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.004454Z","caller":"traceutil/trace.go:171","msg":"trace[56763670] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"118.397989ms","start":"2026-08-12T17:31:06.886029Z","end":"2026-08-12T17:31:07.004427Z","steps":["trace[56763670] 'process raft request'  (duration: 117.983935ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.005262Z","caller":"traceutil/trace.go:171","msg":"trace[421504350] transaction","detail":"{read_only:false; number_of_response:1; response_revision:573; }","duration":"116.841352ms","start":"2026-08-12T17:31:06.887893Z","end":"2026-08-12T17:31:07.004735Z","steps":["trace[421504350] 'process raft request'  (duration: 116.507524ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.006839Z","caller":"traceutil/trace.go:171","msg":"trace[141602633] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"102.0739ms","start":"2026-08-12T17:31:06.904742Z","end":"2026-08-12T17:31:07.006816Z","steps":["trace[141602633] 'process raft request'  (duration: 99.918305ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.155907Z","caller":"traceutil/trace.go:171","msg":"trace[1345510633] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"100.757143ms","start":"2026-08-12T17:31:07.055122Z","end":"2026-08-12T17:31:07.155879Z","steps":["trace[1345510633] 'process raft request'  (duration: 61.275885ms)","trace[1345510633] 'compare'  (duration: 39.361208ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:31:07.232256Z","caller":"traceutil/trace.go:171","msg":"trace[2129704824] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"116.972813ms","start":"2026-08-12T17:31:07.115264Z","end":"2026-08-12T17:31:07.232237Z","steps":["trace[2129704824] 'process raft request'  (duration: 116.472923ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.394502Z","caller":"traceutil/trace.go:171","msg":"trace[592749469] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"274.898535ms","start":"2026-08-12T17:31:07.119577Z","end":"2026-08-12T17:31:07.394476Z","steps":["trace[592749469] 'process raft request'  (duration: 269.626516ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.395154Z","caller":"traceutil/trace.go:171","msg":"trace[1271638082] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"226.815736ms","start":"2026-08-12T17:31:07.168327Z","end":"2026-08-12T17:31:07.395143Z","steps":["trace[1271638082] 'process raft request'  (duration: 226.100907ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:31:07.395274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.251753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-08-12T17:31:07.395325Z","caller":"traceutil/trace.go:171","msg":"trace[1701561695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"188.344441ms","start":"2026-08-12T17:31:07.206968Z","end":"2026-08-12T17:31:07.395313Z","steps":["trace[1701561695] 'agreement among raft nodes before linearized reading'  (duration: 188.245522ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:07.395112Z","caller":"traceutil/trace.go:171","msg":"trace[429767837] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:598; }","duration":"188.08983ms","start":"2026-08-12T17:31:07.207009Z","end":"2026-08-12T17:31:07.395099Z","steps":["trace[429767837] 'read index received'  (duration: 25.066523ms)","trace[429767837] 'applied index is now lower than readState.Index'  (duration: 163.022217ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:31:07.399176Z","caller":"traceutil/trace.go:171","msg":"trace[910339640] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"146.385671ms","start":"2026-08-12T17:31:07.252771Z","end":"2026-08-12T17:31:07.399157Z","steps":["trace[910339640] 'process raft request'  (duration: 146.224108ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:12.862762Z","caller":"traceutil/trace.go:171","msg":"trace[1414350423] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"103.538593ms","start":"2026-08-12T17:31:12.759198Z","end":"2026-08-12T17:31:12.862736Z","steps":["trace[1414350423] 'read index received'  (duration: 102.632368ms)","trace[1414350423] 'applied index is now lower than readState.Index'  (duration: 905.324µs)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:31:12.862881Z","caller":"traceutil/trace.go:171","msg":"trace[1982978416] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"126.931699ms","start":"2026-08-12T17:31:12.73594Z","end":"2026-08-12T17:31:12.862871Z","steps":["trace[1982978416] 'process raft request'  (duration: 126.203019ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:31:12.863302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.092518ms","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-08-12T17:31:12.863358Z","caller":"traceutil/trace.go:171","msg":"trace[1467902420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"104.186835ms","start":"2026-08-12T17:31:12.759155Z","end":"2026-08-12T17:31:12.863342Z","steps":["trace[1467902420] 'agreement among raft nodes before linearized reading'  (duration: 104.014421ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:31:12.863602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.910813ms","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-08-12T17:31:12.863646Z","caller":"traceutil/trace.go:171","msg":"trace[1234420838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"103.99518ms","start":"2026-08-12T17:31:12.759638Z","end":"2026-08-12T17:31:12.863633Z","steps":["trace[1234420838] 'agreement among raft nodes before linearized reading'  (duration: 103.898782ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:13.036487Z","caller":"traceutil/trace.go:171","msg":"trace[1542830877] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"167.599063ms","start":"2026-08-12T17:31:12.868854Z","end":"2026-08-12T17:31:13.036453Z","steps":["trace[1542830877] 'process raft request'  (duration: 151.288855ms)","trace[1542830877] 'compare'  (duration: 15.963819ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:31:13.218083Z","caller":"traceutil/trace.go:171","msg":"trace[245254328] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"171.243912ms","start":"2026-08-12T17:31:13.046817Z","end":"2026-08-12T17:31:13.218061Z","steps":["trace[245254328] 'read index received'  (duration: 91.371213ms)","trace[245254328] 'applied index is now lower than readState.Index'  (duration: 79.871789ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:31:13.218314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.478622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7m8hq\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-08-12T17:31:13.218356Z","caller":"traceutil/trace.go:171","msg":"trace[1674143252] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7m8hq; range_end:; response_count:1; response_revision:627; }","duration":"171.57609ms","start":"2026-08-12T17:31:13.046769Z","end":"2026-08-12T17:31:13.218345Z","steps":["trace[1674143252] 'agreement among raft nodes before linearized reading'  (duration: 171.385624ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:13.219668Z","caller":"traceutil/trace.go:171","msg":"trace[1933723408] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"350.647324ms","start":"2026-08-12T17:31:12.869001Z","end":"2026-08-12T17:31:13.219648Z","steps":["trace[1933723408] 'process raft request'  (duration: 269.191814ms)","trace[1933723408] 'compare'  (duration: 79.689635ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:31:13.219807Z","caller":"traceutil/trace.go:171","msg":"trace[729001399] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"304.306327ms","start":"2026-08-12T17:31:12.915456Z","end":"2026-08-12T17:31:13.219762Z","steps":["trace[729001399] 'process raft request'  (duration: 302.561284ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:31:13.220173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:31:12.868979Z","time spent":"350.736791ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:609 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-12T17:31:13.220297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:31:12.915439Z","time spent":"304.45721ms","remote":"127.0.0.1:56454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-08-12T17:31:13.544202Z","caller":"traceutil/trace.go:171","msg":"trace[153325731] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"120.49102ms","start":"2026-08-12T17:31:13.423672Z","end":"2026-08-12T17:31:13.544163Z","steps":["trace[153325731] 'read index received'  (duration: 100.004261ms)","trace[153325731] 'applied index is now lower than readState.Index'  (duration: 20.485299ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:31:13.544261Z","caller":"traceutil/trace.go:171","msg":"trace[133304992] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"306.371223ms","start":"2026-08-12T17:31:13.237838Z","end":"2026-08-12T17:31:13.544209Z","steps":["trace[133304992] 'process raft request'  (duration: 285.878703ms)","trace[133304992] 'compare'  (duration: 20.165453ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:31:13.544402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:31:13.237825Z","time spent":"306.502034ms","remote":"127.0.0.1:56072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-7m8hq\" mod_revision:509 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-7m8hq\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-7m8hq\" > >"}
{"level":"warn","ts":"2026-08-12T17:31:13.544507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.811747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-12T17:31:13.544551Z","caller":"traceutil/trace.go:171","msg":"trace[892124452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"120.902614ms","start":"2026-08-12T17:31:13.423636Z","end":"2026-08-12T17:31:13.544539Z","steps":["trace[892124452] 'agreement among raft nodes before linearized reading'  (duration: 120.695227ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:13.727748Z","caller":"traceutil/trace.go:171","msg":"trace[1390226619] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"101.419297ms","start":"2026-08-12T17:31:13.626305Z","end":"2026-08-12T17:31:13.727724Z","steps":["trace[1390226619] 'process raft request'  (duration: 100.010412ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:31:27.497609Z","caller":"traceutil/trace.go:171","msg":"trace[2143606991] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"182.526153ms","start":"2026-08-12T17:31:27.315033Z","end":"2026-08-12T17:31:27.49756Z","steps":["trace[2143606991] 'process raft request'  (duration: 182.256741ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:32:17.543414Z","caller":"traceutil/trace.go:171","msg":"trace[1416930394] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"110.218187ms","start":"2026-08-12T17:32:17.433171Z","end":"2026-08-12T17:32:17.543389Z","steps":["trace[1416930394] 'process raft request'  (duration: 109.800848ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:32:41.974176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.649042ms","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-08-12T17:32:41.974283Z","caller":"traceutil/trace.go:171","msg":"trace[2112031780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1841; }","duration":"295.803304ms","start":"2026-08-12T17:32:41.678461Z","end":"2026-08-12T17:32:41.974265Z","steps":["trace[2112031780] 'range keys from in-memory index tree'  (duration: 295.481959ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:32:41.974454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.751609ms","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-08-12T17:32:41.974561Z","caller":"traceutil/trace.go:171","msg":"trace[1664114047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1841; }","duration":"151.919422ms","start":"2026-08-12T17:32:41.822617Z","end":"2026-08-12T17:32:41.974537Z","steps":["trace[1664114047] 'range keys from in-memory index tree'  (duration: 151.493295ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:32:42.499556Z","caller":"traceutil/trace.go:171","msg":"trace[1258196542] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"141.194179ms","start":"2026-08-12T17:32:42.358341Z","end":"2026-08-12T17:32:42.499535Z","steps":["trace[1258196542] 'read index received'  (duration: 141.008446ms)","trace[1258196542] 'applied index is now lower than readState.Index'  (duration: 185.103µs)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:32:42.499592Z","caller":"traceutil/trace.go:171","msg":"trace[556832767] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"157.614907ms","start":"2026-08-12T17:32:42.341962Z","end":"2026-08-12T17:32:42.499577Z","steps":["trace[556832767] 'process raft request'  (duration: 157.455144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:32:42.499671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.319831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:32:42.499697Z","caller":"traceutil/trace.go:171","msg":"trace[2045072788] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1845; }","duration":"141.419673ms","start":"2026-08-12T17:32:42.358271Z","end":"2026-08-12T17:32:42.49969Z","steps":["trace[2045072788] 'agreement among raft nodes before linearized reading'  (duration: 141.352692ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:32:54.910084Z","caller":"traceutil/trace.go:171","msg":"trace[1246741046] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"122.07767ms","start":"2026-08-12T17:32:54.787977Z","end":"2026-08-12T17:32:54.910055Z","steps":["trace[1246741046] 'process raft request'  (duration: 121.874814ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:33:16.357925Z","caller":"traceutil/trace.go:171","msg":"trace[1002907616] linearizableReadLoop","detail":"{readStateIndex:2165; appliedIndex:2163; }","duration":"176.680056ms","start":"2026-08-12T17:33:16.181215Z","end":"2026-08-12T17:33:16.357895Z","steps":["trace[1002907616] 'read index received'  (duration: 21.878903ms)","trace[1002907616] 'applied index is now lower than readState.Index'  (duration: 154.796993ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:33:16.358211Z","caller":"traceutil/trace.go:171","msg":"trace[1205243225] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"179.413863ms","start":"2026-08-12T17:33:16.178777Z","end":"2026-08-12T17:33:16.358191Z","steps":["trace[1205243225] 'process raft request'  (duration: 122.523795ms)","trace[1205243225] 'compare'  (duration: 56.477011ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:33:16.358682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.444236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-08-12T17:33:16.358744Z","caller":"traceutil/trace.go:171","msg":"trace[462398363] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2085; }","duration":"177.54232ms","start":"2026-08-12T17:33:16.181187Z","end":"2026-08-12T17:33:16.358729Z","steps":["trace[462398363] 'agreement among raft nodes before linearized reading'  (duration: 176.830442ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:33:17.09965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.470227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-08-12T17:33:17.09973Z","caller":"traceutil/trace.go:171","msg":"trace[1990385915] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2086; }","duration":"372.598331ms","start":"2026-08-12T17:33:16.727111Z","end":"2026-08-12T17:33:17.099709Z","steps":["trace[1990385915] 'range keys from in-memory index tree'  (duration: 372.29678ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:33:17.09977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:33:16.727085Z","time spent":"372.676494ms","remote":"127.0.0.1:33628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5468,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-08-12T17:33:17.100023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.83995ms","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-08-12T17:33:17.100107Z","caller":"traceutil/trace.go:171","msg":"trace[548876297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2086; }","duration":"432.003207ms","start":"2026-08-12T17:33:16.66808Z","end":"2026-08-12T17:33:17.100084Z","steps":["trace[548876297] 'range keys from in-memory index tree'  (duration: 431.638883ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:33:17.100159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:33:16.66805Z","time spent":"432.096471ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-12T17:33:17.397283Z","caller":"traceutil/trace.go:171","msg":"trace[1813901332] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"129.960021ms","start":"2026-08-12T17:33:17.267284Z","end":"2026-08-12T17:33:17.397244Z","steps":["trace[1813901332] 'process raft request'  (duration: 82.266622ms)","trace[1813901332] 'compare'  (duration: 47.369627ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:33:17.651331Z","caller":"traceutil/trace.go:171","msg":"trace[1514401032] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"272.186644ms","start":"2026-08-12T17:33:17.379118Z","end":"2026-08-12T17:33:17.651304Z","steps":["trace[1514401032] 'process raft request'  (duration: 272.021087ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:33:17.690282Z","caller":"traceutil/trace.go:171","msg":"trace[919909923] linearizableReadLoop","detail":"{readStateIndex:2171; appliedIndex:2169; }","duration":"233.098154ms","start":"2026-08-12T17:33:17.457161Z","end":"2026-08-12T17:33:17.690259Z","steps":["trace[919909923] 'read index received'  (duration: 194.123458ms)","trace[919909923] 'applied index is now lower than readState.Index'  (duration: 38.973546ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:33:17.690427Z","caller":"traceutil/trace.go:171","msg":"trace[2020375323] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"148.656687ms","start":"2026-08-12T17:33:17.541754Z","end":"2026-08-12T17:33:17.69041Z","steps":["trace[2020375323] 'process raft request'  (duration: 148.463359ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:33:17.690347Z","caller":"traceutil/trace.go:171","msg":"trace[1672984457] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"310.442361ms","start":"2026-08-12T17:33:17.379867Z","end":"2026-08-12T17:33:17.690309Z","steps":["trace[1672984457] 'process raft request'  (duration: 310.228772ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:33:17.690753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.575082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:33:17.690796Z","caller":"traceutil/trace.go:171","msg":"trace[1502437813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2092; }","duration":"233.667067ms","start":"2026-08-12T17:33:17.457118Z","end":"2026-08-12T17:33:17.690786Z","steps":["trace[1502437813] 'agreement among raft nodes before linearized reading'  (duration: 233.551812ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:33:17.69077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:33:17.379842Z","time spent":"310.803195ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2081 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-12T17:33:17.691164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.235214ms","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-08-12T17:33:17.691345Z","caller":"traceutil/trace.go:171","msg":"trace[1419728221] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2092; }","duration":"191.478113ms","start":"2026-08-12T17:33:17.499839Z","end":"2026-08-12T17:33:17.691317Z","steps":["trace[1419728221] 'agreement among raft nodes before linearized reading'  (duration: 190.988064ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:33:17.907861Z","caller":"traceutil/trace.go:171","msg":"trace[1257991508] linearizableReadLoop","detail":"{readStateIndex:2173; appliedIndex:2172; }","duration":"131.647297ms","start":"2026-08-12T17:33:17.776182Z","end":"2026-08-12T17:33:17.90783Z","steps":["trace[1257991508] 'read index received'  (duration: 64.030033ms)","trace[1257991508] 'applied index is now lower than readState.Index'  (duration: 67.615704ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:33:17.908047Z","caller":"traceutil/trace.go:171","msg":"trace[1029055083] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"211.486973ms","start":"2026-08-12T17:33:17.69653Z","end":"2026-08-12T17:33:17.908017Z","steps":["trace[1029055083] 'process raft request'  (duration: 143.711173ms)","trace[1029055083] 'compare'  (duration: 67.372784ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:33:17.908153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.945189ms","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-08-12T17:33:17.908214Z","caller":"traceutil/trace.go:171","msg":"trace[358634778] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2093; }","duration":"132.057983ms","start":"2026-08-12T17:33:17.776138Z","end":"2026-08-12T17:33:17.908196Z","steps":["trace[358634778] 'agreement among raft nodes before linearized reading'  (duration: 131.811643ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:34:20.528815Z","caller":"traceutil/trace.go:171","msg":"trace[928410756] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"203.221326ms","start":"2026-08-12T17:34:20.325555Z","end":"2026-08-12T17:34:20.528776Z","steps":["trace[928410756] 'process raft request'  (duration: 203.049786ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:34:53.540449Z","caller":"traceutil/trace.go:171","msg":"trace[640226618] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"121.566998ms","start":"2026-08-12T17:34:53.418833Z","end":"2026-08-12T17:34:53.5404Z","steps":["trace[640226618] 'process raft request'  (duration: 121.413378ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:38:42.547833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.481234ms","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-08-12T17:38:42.547964Z","caller":"traceutil/trace.go:171","msg":"trace[867179041] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4624; }","duration":"107.632301ms","start":"2026-08-12T17:38:42.440313Z","end":"2026-08-12T17:38:42.547945Z","steps":["trace[867179041] 'range keys from in-memory index tree'  (duration: 107.461094ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:38:42.553493Z","caller":"traceutil/trace.go:171","msg":"trace[486431652] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"204.724517ms","start":"2026-08-12T17:38:42.348746Z","end":"2026-08-12T17:38:42.55347Z","steps":["trace[486431652] 'process raft request'  (duration: 204.597852ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:38:42.608051Z","caller":"traceutil/trace.go:171","msg":"trace[1032534066] linearizableReadLoop","detail":"{readStateIndex:4807; appliedIndex:4805; }","duration":"165.9506ms","start":"2026-08-12T17:38:42.442077Z","end":"2026-08-12T17:38:42.608027Z","steps":["trace[1032534066] 'read index received'  (duration: 110.932826ms)","trace[1032534066] 'applied index is now lower than readState.Index'  (duration: 55.016804ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:38:42.608241Z","caller":"traceutil/trace.go:171","msg":"trace[258633442] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"250.635126ms","start":"2026-08-12T17:38:42.357587Z","end":"2026-08-12T17:38:42.608222Z","steps":["trace[258633442] 'process raft request'  (duration: 250.308603ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:38:42.608522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.430631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"}
{"level":"info","ts":"2026-08-12T17:38:42.608573Z","caller":"traceutil/trace.go:171","msg":"trace[1837188581] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4626; }","duration":"166.515104ms","start":"2026-08-12T17:38:42.442045Z","end":"2026-08-12T17:38:42.608561Z","steps":["trace[1837188581] 'agreement among raft nodes before linearized reading'  (duration: 166.332487ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:38:48.1351Z","caller":"traceutil/trace.go:171","msg":"trace[902284415] linearizableReadLoop","detail":"{readStateIndex:4910; appliedIndex:4909; }","duration":"112.76205ms","start":"2026-08-12T17:38:48.022313Z","end":"2026-08-12T17:38:48.135075Z","steps":["trace[902284415] 'read index received'  (duration: 112.600013ms)","trace[902284415] 'applied index is now lower than readState.Index'  (duration: 160.877µs)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:38:48.135152Z","caller":"traceutil/trace.go:171","msg":"trace[493369138] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"133.314963ms","start":"2026-08-12T17:38:48.001799Z","end":"2026-08-12T17:38:48.135114Z","steps":["trace[493369138] 'process raft request'  (duration: 133.127115ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:38:48.135491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.120135ms","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-08-12T17:38:48.135885Z","caller":"traceutil/trace.go:171","msg":"trace[1421046160] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4728; }","duration":"113.590375ms","start":"2026-08-12T17:38:48.022269Z","end":"2026-08-12T17:38:48.135859Z","steps":["trace[1421046160] 'agreement among raft nodes before linearized reading'  (duration: 112.953348ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:38:48.362525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.276771ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454758237 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4660 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-12T17:38:48.362627Z","caller":"traceutil/trace.go:171","msg":"trace[501683682] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"220.901076ms","start":"2026-08-12T17:38:48.141707Z","end":"2026-08-12T17:38:48.362608Z","steps":["trace[501683682] 'process raft request'  (duration: 102.286121ms)","trace[501683682] 'compare'  (duration: 118.079023ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:38:48.369436Z","caller":"traceutil/trace.go:171","msg":"trace[156015190] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"227.474212ms","start":"2026-08-12T17:38:48.141931Z","end":"2026-08-12T17:38:48.369405Z","steps":["trace[156015190] 'process raft request'  (duration: 227.341677ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:38:48.369673Z","caller":"traceutil/trace.go:171","msg":"trace[1050398432] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"227.42064ms","start":"2026-08-12T17:38:48.142245Z","end":"2026-08-12T17:38:48.369666Z","steps":["trace[1050398432] 'process raft request'  (duration: 227.132248ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:38:48.369694Z","caller":"traceutil/trace.go:171","msg":"trace[973120591] linearizableReadLoop","detail":"{readStateIndex:4913; appliedIndex:4910; }","duration":"222.038694ms","start":"2026-08-12T17:38:48.147632Z","end":"2026-08-12T17:38:48.36967Z","steps":["trace[973120591] 'read index received'  (duration: 96.375163ms)","trace[973120591] 'applied index is now lower than readState.Index'  (duration: 125.662701ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:38:48.369764Z","caller":"traceutil/trace.go:171","msg":"trace[864086030] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"143.166946ms","start":"2026-08-12T17:38:48.226563Z","end":"2026-08-12T17:38:48.36973Z","steps":["trace[864086030] 'process raft request'  (duration: 142.990638ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:38:48.369867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.209511ms","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":"warn","ts":"2026-08-12T17:38:48.369916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.23084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05afaaa0-fb1a-46fe-b9f1-3275b2845d96\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-08-12T17:38:48.369919Z","caller":"traceutil/trace.go:171","msg":"trace[391505582] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:4732; }","duration":"222.344717ms","start":"2026-08-12T17:38:48.147559Z","end":"2026-08-12T17:38:48.369904Z","steps":["trace[391505582] 'agreement among raft nodes before linearized reading'  (duration: 222.225842ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:38:48.369928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.077328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-05afaaa0-fb1a-46fe-b9f1-3275b2845d96\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-08-12T17:38:48.369943Z","caller":"traceutil/trace.go:171","msg":"trace[475127141] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-05afaaa0-fb1a-46fe-b9f1-3275b2845d96; range_end:; response_count:1; response_revision:4732; }","duration":"149.305243ms","start":"2026-08-12T17:38:48.220629Z","end":"2026-08-12T17:38:48.369934Z","steps":["trace[475127141] 'agreement among raft nodes before linearized reading'  (duration: 149.194089ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:38:48.36996Z","caller":"traceutil/trace.go:171","msg":"trace[1965805825] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-05afaaa0-fb1a-46fe-b9f1-3275b2845d96; range_end:; response_count:1; response_revision:4732; }","duration":"213.166862ms","start":"2026-08-12T17:38:48.156784Z","end":"2026-08-12T17:38:48.369951Z","steps":["trace[1965805825] 'agreement among raft nodes before linearized reading'  (duration: 213.029356ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:02.136455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.643122ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454758644 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18cb1f86f426fda1\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18cb1f86f426fda1\" value_size:781 lease:5036607641599981109 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-12T17:39:02.136568Z","caller":"traceutil/trace.go:171","msg":"trace[177881773] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5093; }","duration":"440.049969ms","start":"2026-08-12T17:39:01.696501Z","end":"2026-08-12T17:39:02.136551Z","steps":["trace[177881773] 'read index received'  (duration: 82.25737ms)","trace[177881773] 'applied index is now lower than readState.Index'  (duration: 357.790639ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:02.136659Z","caller":"traceutil/trace.go:171","msg":"trace[1962945873] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"468.55791ms","start":"2026-08-12T17:39:01.668088Z","end":"2026-08-12T17:39:02.136646Z","steps":["trace[1962945873] 'process raft request'  (duration: 110.626355ms)","trace[1962945873] 'compare'  (duration: 357.36097ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:39:02.13671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:39:01.668069Z","time spent":"468.614603ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":889,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18cb1f86f426fda1\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18cb1f86f426fda1\" value_size:781 lease:5036607641599981109 >> failure:<>"}
{"level":"warn","ts":"2026-08-12T17:39:02.13705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.063911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"warn","ts":"2026-08-12T17:39:02.137144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.635315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-12T17:39:02.137158Z","caller":"traceutil/trace.go:171","msg":"trace[1378213880] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4905; }","duration":"290.210947ms","start":"2026-08-12T17:39:01.846916Z","end":"2026-08-12T17:39:02.137127Z","steps":["trace[1378213880] 'agreement among raft nodes before linearized reading'  (duration: 289.939645ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:02.137187Z","caller":"traceutil/trace.go:171","msg":"trace[1001741624] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4905; }","duration":"440.725558ms","start":"2026-08-12T17:39:01.69645Z","end":"2026-08-12T17:39:02.137176Z","steps":["trace[1001741624] 'agreement among raft nodes before linearized reading'  (duration: 440.53948ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:02.137222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:39:01.696402Z","time spent":"440.812393ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-08-12T17:39:02.622996Z","caller":"traceutil/trace.go:171","msg":"trace[134584376] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"124.793346ms","start":"2026-08-12T17:39:02.498163Z","end":"2026-08-12T17:39:02.622957Z","steps":["trace[134584376] 'process raft request'  (duration: 70.610262ms)","trace[134584376] 'compare'  (duration: 53.819588ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:02.623052Z","caller":"traceutil/trace.go:171","msg":"trace[128024088] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"124.453671ms","start":"2026-08-12T17:39:02.498568Z","end":"2026-08-12T17:39:02.623022Z","steps":["trace[128024088] 'process raft request'  (duration: 124.162878ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:13.697688Z","caller":"traceutil/trace.go:171","msg":"trace[375773644] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"167.746554ms","start":"2026-08-12T17:39:13.529912Z","end":"2026-08-12T17:39:13.697659Z","steps":["trace[375773644] 'process raft request'  (duration: 104.170232ms)","trace[375773644] 'compare'  (duration: 63.429255ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:20.431707Z","caller":"traceutil/trace.go:171","msg":"trace[1385646523] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"112.919955ms","start":"2026-08-12T17:39:20.318756Z","end":"2026-08-12T17:39:20.431676Z","steps":["trace[1385646523] 'process raft request'  (duration: 47.649901ms)","trace[1385646523] 'compare'  (duration: 65.073145ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:20.787425Z","caller":"traceutil/trace.go:171","msg":"trace[794005706] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"192.447459ms","start":"2026-08-12T17:39:20.594941Z","end":"2026-08-12T17:39:20.787388Z","steps":["trace[794005706] 'process raft request'  (duration: 165.060981ms)","trace[794005706] 'compare'  (duration: 27.152068ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:21.103797Z","caller":"traceutil/trace.go:171","msg":"trace[760901614] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"121.767788ms","start":"2026-08-12T17:39:20.982003Z","end":"2026-08-12T17:39:21.103771Z","steps":["trace[760901614] 'process raft request'  (duration: 121.58742ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:22.986806Z","caller":"traceutil/trace.go:171","msg":"trace[1304354504] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"167.797719ms","start":"2026-08-12T17:39:22.818976Z","end":"2026-08-12T17:39:22.986774Z","steps":["trace[1304354504] 'process raft request'  (duration: 128.724591ms)","trace[1304354504] 'compare'  (duration: 38.742853ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:22.987241Z","caller":"traceutil/trace.go:171","msg":"trace[87409673] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"167.880523ms","start":"2026-08-12T17:39:22.81933Z","end":"2026-08-12T17:39:22.98721Z","steps":["trace[87409673] 'process raft request'  (duration: 167.411682ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:22.987283Z","caller":"traceutil/trace.go:171","msg":"trace[1232162838] transaction","detail":"{read_only:false; response_revision:5059; number_of_response:1; }","duration":"168.241669ms","start":"2026-08-12T17:39:22.819029Z","end":"2026-08-12T17:39:22.987271Z","steps":["trace[1232162838] 'process raft request'  (duration: 167.628041ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:22.98692Z","caller":"traceutil/trace.go:171","msg":"trace[2128165326] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"161.970433ms","start":"2026-08-12T17:39:22.824923Z","end":"2026-08-12T17:39:22.986893Z","steps":["trace[2128165326] 'process raft request'  (duration: 161.91567ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:22.987338Z","caller":"traceutil/trace.go:171","msg":"trace[1220169360] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"167.498615ms","start":"2026-08-12T17:39:22.819773Z","end":"2026-08-12T17:39:22.987271Z","steps":["trace[1220169360] 'process raft request'  (duration: 167.008632ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:24.835844Z","caller":"traceutil/trace.go:171","msg":"trace[413706772] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"173.706113ms","start":"2026-08-12T17:39:24.662103Z","end":"2026-08-12T17:39:24.835809Z","steps":["trace[413706772] 'process raft request'  (duration: 88.238425ms)","trace[413706772] 'compare'  (duration: 85.350393ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:48.866114Z","caller":"traceutil/trace.go:171","msg":"trace[1692368558] linearizableReadLoop","detail":"{readStateIndex:5493; appliedIndex:5492; }","duration":"269.82315ms","start":"2026-08-12T17:39:48.596262Z","end":"2026-08-12T17:39:48.866086Z","steps":["trace[1692368558] 'read index received'  (duration: 269.566797ms)","trace[1692368558] 'applied index is now lower than readState.Index'  (duration: 255.263µs)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:48.866448Z","caller":"traceutil/trace.go:171","msg":"trace[291272565] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"278.14826ms","start":"2026-08-12T17:39:48.588291Z","end":"2026-08-12T17:39:48.866439Z","steps":["trace[291272565] 'process raft request'  (duration: 277.627024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:48.866619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.341634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:39:48.866644Z","caller":"traceutil/trace.go:171","msg":"trace[292304448] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5293; }","duration":"270.426088ms","start":"2026-08-12T17:39:48.59621Z","end":"2026-08-12T17:39:48.866636Z","steps":["trace[292304448] 'agreement among raft nodes before linearized reading'  (duration: 270.364695ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:48.866764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.24886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:39:48.866781Z","caller":"traceutil/trace.go:171","msg":"trace[1320088541] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5293; }","duration":"270.376926ms","start":"2026-08-12T17:39:48.596399Z","end":"2026-08-12T17:39:48.866776Z","steps":["trace[1320088541] 'agreement among raft nodes before linearized reading'  (duration: 270.347734ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:48.867113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.913287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-12T17:39:48.867133Z","caller":"traceutil/trace.go:171","msg":"trace[1171724897] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5293; }","duration":"133.9691ms","start":"2026-08-12T17:39:48.733158Z","end":"2026-08-12T17:39:48.867127Z","steps":["trace[1171724897] 'agreement among raft nodes before linearized reading'  (duration: 133.904466ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:48.867285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.672318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"}
{"level":"info","ts":"2026-08-12T17:39:48.867303Z","caller":"traceutil/trace.go:171","msg":"trace[1564537851] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5293; }","duration":"261.738281ms","start":"2026-08-12T17:39:48.605559Z","end":"2026-08-12T17:39:48.867298Z","steps":["trace[1564537851] 'agreement among raft nodes before linearized reading'  (duration: 261.680068ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:48.997679Z","caller":"traceutil/trace.go:171","msg":"trace[19478689] linearizableReadLoop","detail":"{readStateIndex:5494; appliedIndex:5493; }","duration":"122.029745ms","start":"2026-08-12T17:39:48.875614Z","end":"2026-08-12T17:39:48.997644Z","steps":["trace[19478689] 'read index received'  (duration: 25.744827ms)","trace[19478689] 'applied index is now lower than readState.Index'  (duration: 96.277528ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:39:48.997959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.32713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-12T17:39:48.998018Z","caller":"traceutil/trace.go:171","msg":"trace[465644266] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5294; }","duration":"122.429755ms","start":"2026-08-12T17:39:48.875576Z","end":"2026-08-12T17:39:48.998006Z","steps":["trace[465644266] 'agreement among raft nodes before linearized reading'  (duration: 122.196383ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:48.997674Z","caller":"traceutil/trace.go:171","msg":"trace[1153638320] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"123.604541ms","start":"2026-08-12T17:39:48.874012Z","end":"2026-08-12T17:39:48.997616Z","steps":["trace[1153638320] 'process raft request'  (duration: 27.633848ms)","trace[1153638320] 'compare'  (duration: 95.734012ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:39:49.407315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.230377ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454759686 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:5239 > 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-08-12T17:39:49.407527Z","caller":"traceutil/trace.go:171","msg":"trace[1217837676] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"241.34549ms","start":"2026-08-12T17:39:49.16616Z","end":"2026-08-12T17:39:49.407506Z","steps":["trace[1217837676] 'process raft request'  (duration: 241.271876ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.407837Z","caller":"traceutil/trace.go:171","msg":"trace[1543328918] linearizableReadLoop","detail":"{readStateIndex:5496; appliedIndex:5495; }","duration":"327.984881ms","start":"2026-08-12T17:39:49.079803Z","end":"2026-08-12T17:39:49.407788Z","steps":["trace[1543328918] 'read index received'  (duration: 39.086182ms)","trace[1543328918] 'applied index is now lower than readState.Index'  (duration: 288.895209ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:49.407965Z","caller":"traceutil/trace.go:171","msg":"trace[721136974] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"328.675695ms","start":"2026-08-12T17:39:49.079269Z","end":"2026-08-12T17:39:49.407945Z","steps":["trace[721136974] 'process raft request'  (duration: 39.723223ms)","trace[721136974] 'compare'  (duration: 288.101101ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:39:49.408079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:39:49.079253Z","time spent":"328.743958ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:5239 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-08-12T17:39:49.408329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.496976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-12T17:39:49.40917Z","caller":"traceutil/trace.go:171","msg":"trace[1789035223] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5297; }","duration":"328.602491ms","start":"2026-08-12T17:39:49.07979Z","end":"2026-08-12T17:39:49.408392Z","steps":["trace[1789035223] 'agreement among raft nodes before linearized reading'  (duration: 328.184511ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:49.409298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:39:49.079784Z","time spent":"329.482743ms","remote":"127.0.0.1:56072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-12T17:39:49.461948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.4302ms","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-08-12T17:39:49.462015Z","caller":"traceutil/trace.go:171","msg":"trace[1246727704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5298; }","duration":"270.570367ms","start":"2026-08-12T17:39:49.191429Z","end":"2026-08-12T17:39:49.462Z","steps":["trace[1246727704] 'agreement among raft nodes before linearized reading'  (duration: 270.359127ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:49.462128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.84738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-12T17:39:49.462211Z","caller":"traceutil/trace.go:171","msg":"trace[409278257] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5298; }","duration":"351.984096ms","start":"2026-08-12T17:39:49.110207Z","end":"2026-08-12T17:39:49.462191Z","steps":["trace[409278257] 'agreement among raft nodes before linearized reading'  (duration: 351.751735ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:49.462257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:39:49.110138Z","time spent":"352.110312ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-08-12T17:39:49.462329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.529281ms","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-08-12T17:39:49.46238Z","caller":"traceutil/trace.go:171","msg":"trace[838632463] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5298; }","duration":"256.637905ms","start":"2026-08-12T17:39:49.205728Z","end":"2026-08-12T17:39:49.462366Z","steps":["trace[838632463] 'agreement among raft nodes before linearized reading'  (duration: 256.52242ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.462159Z","caller":"traceutil/trace.go:171","msg":"trace[164995178] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"219.865195ms","start":"2026-08-12T17:39:49.24227Z","end":"2026-08-12T17:39:49.462135Z","steps":["trace[164995178] 'process raft request'  (duration: 219.289638ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.572573Z","caller":"traceutil/trace.go:171","msg":"trace[924087265] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"107.37293ms","start":"2026-08-12T17:39:49.465144Z","end":"2026-08-12T17:39:49.572517Z","steps":["trace[924087265] 'process raft request'  (duration: 62.456048ms)","trace[924087265] 'compare'  (duration: 44.573055ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:49.572829Z","caller":"traceutil/trace.go:171","msg":"trace[79060848] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"105.964122ms","start":"2026-08-12T17:39:49.466427Z","end":"2026-08-12T17:39:49.572391Z","steps":["trace[79060848] 'process raft request'  (duration: 105.883858ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.572809Z","caller":"traceutil/trace.go:171","msg":"trace[520569255] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"105.421725ms","start":"2026-08-12T17:39:49.467227Z","end":"2026-08-12T17:39:49.572648Z","steps":["trace[520569255] 'process raft request'  (duration: 105.127101ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.57321Z","caller":"traceutil/trace.go:171","msg":"trace[1807173168] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"105.546281ms","start":"2026-08-12T17:39:49.46765Z","end":"2026-08-12T17:39:49.573196Z","steps":["trace[1807173168] 'process raft request'  (duration: 104.932882ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.57328Z","caller":"traceutil/trace.go:171","msg":"trace[99993193] linearizableReadLoop","detail":"{readStateIndex:5500; appliedIndex:5498; }","duration":"106.593722ms","start":"2026-08-12T17:39:49.466674Z","end":"2026-08-12T17:39:49.573268Z","steps":["trace[99993193] 'read index received'  (duration: 60.940014ms)","trace[99993193] 'applied index is now lower than readState.Index'  (duration: 45.651358ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:49.57332Z","caller":"traceutil/trace.go:171","msg":"trace[982550253] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"101.647434ms","start":"2026-08-12T17:39:49.471663Z","end":"2026-08-12T17:39:49.57331Z","steps":["trace[982550253] 'process raft request'  (duration: 101.471545ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:39:49.573814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.101746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"}
{"level":"warn","ts":"2026-08-12T17:39:49.574128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.437366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"info","ts":"2026-08-12T17:39:49.574183Z","caller":"traceutil/trace.go:171","msg":"trace[446273080] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5303; }","duration":"100.53323ms","start":"2026-08-12T17:39:49.473637Z","end":"2026-08-12T17:39:49.574171Z","steps":["trace[446273080] 'agreement among raft nodes before linearized reading'  (duration: 99.969743ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.573923Z","caller":"traceutil/trace.go:171","msg":"trace[569389202] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5303; }","duration":"107.245423ms","start":"2026-08-12T17:39:49.466651Z","end":"2026-08-12T17:39:49.573896Z","steps":["trace[569389202] 'agreement among raft nodes before linearized reading'  (duration: 106.846954ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:39:49.720755Z","caller":"traceutil/trace.go:171","msg":"trace[2100294815] linearizableReadLoop","detail":"{readStateIndex:5504; appliedIndex:5503; }","duration":"131.087942ms","start":"2026-08-12T17:39:49.589637Z","end":"2026-08-12T17:39:49.720725Z","steps":["trace[2100294815] 'read index received'  (duration: 120.88546ms)","trace[2100294815] 'applied index is now lower than readState.Index'  (duration: 10.200742ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:39:49.720914Z","caller":"traceutil/trace.go:171","msg":"trace[570456771] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"133.538009ms","start":"2026-08-12T17:39:49.587361Z","end":"2026-08-12T17:39:49.720899Z","steps":["trace[570456771] 'process raft request'  (duration: 123.150319ms)","trace[570456771] 'compare'  (duration: 10.090836ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:39:49.721279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.622027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-08-12T17:39:49.721328Z","caller":"traceutil/trace.go:171","msg":"trace[569115186] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5304; }","duration":"131.715592ms","start":"2026-08-12T17:39:49.589601Z","end":"2026-08-12T17:39:49.721316Z","steps":["trace[569115186] 'agreement among raft nodes before linearized reading'  (duration: 131.46951ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:01.724771Z","caller":"traceutil/trace.go:171","msg":"trace[1517420562] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"100.363424ms","start":"2026-08-12T17:40:01.624385Z","end":"2026-08-12T17:40:01.724748Z","steps":["trace[1517420562] 'process raft request'  (duration: 99.982655ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:01.943708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.149846ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454759919 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5379 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-12T17:40:01.943838Z","caller":"traceutil/trace.go:171","msg":"trace[963619775] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"214.892851ms","start":"2026-08-12T17:40:01.72892Z","end":"2026-08-12T17:40:01.943812Z","steps":["trace[963619775] 'process raft request'  (duration: 65.519754ms)","trace[963619775] 'compare'  (duration: 148.965907ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:02.299416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.474979ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454759920 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5377 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-12T17:40:02.299607Z","caller":"traceutil/trace.go:171","msg":"trace[1558692724] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"570.450362ms","start":"2026-08-12T17:40:01.729132Z","end":"2026-08-12T17:40:02.299582Z","steps":["trace[1558692724] 'process raft request'  (duration: 359.456767ms)","trace[1558692724] 'compare'  (duration: 209.987246ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:02.299722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:01.729121Z","time spent":"570.540377ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5377 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-12T17:40:02.299861Z","caller":"traceutil/trace.go:171","msg":"trace[1343637630] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"569.437523ms","start":"2026-08-12T17:40:01.730397Z","end":"2026-08-12T17:40:02.299834Z","steps":["trace[1343637630] 'process raft request'  (duration: 569.129008ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:02.299912Z","caller":"traceutil/trace.go:171","msg":"trace[1026306987] linearizableReadLoop","detail":"{readStateIndex:5592; appliedIndex:5589; }","duration":"384.239489ms","start":"2026-08-12T17:40:01.915653Z","end":"2026-08-12T17:40:02.299893Z","steps":["trace[1026306987] 'read index received'  (duration: 172.877065ms)","trace[1026306987] 'applied index is now lower than readState.Index'  (duration: 211.361494ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:02.299965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:01.730367Z","time spent":"569.542278ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5378 > 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-08-12T17:40:02.299994Z","caller":"traceutil/trace.go:171","msg":"trace[198960424] transaction","detail":"{read_only:false; response_revision:5389; number_of_response:1; }","duration":"477.123915ms","start":"2026-08-12T17:40:01.822862Z","end":"2026-08-12T17:40:02.299986Z","steps":["trace[198960424] 'process raft request'  (duration: 476.906384ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:02.300063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.021386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:40:02.300098Z","caller":"traceutil/trace.go:171","msg":"trace[1772535222] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:5389; }","duration":"312.090409ms","start":"2026-08-12T17:40:01.987996Z","end":"2026-08-12T17:40:02.300087Z","steps":["trace[1772535222] 'agreement among raft nodes before linearized reading'  (duration: 312.038097ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:02.300122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:01.987976Z","time spent":"312.140962ms","remote":"127.0.0.1:33442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "}
{"level":"warn","ts":"2026-08-12T17:40:02.300121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.47158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:40:02.300147Z","caller":"traceutil/trace.go:171","msg":"trace[2124196759] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:5389; }","duration":"384.499362ms","start":"2026-08-12T17:40:01.91564Z","end":"2026-08-12T17:40:02.300139Z","steps":["trace[2124196759] 'agreement among raft nodes before linearized reading'  (duration: 384.453989ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:02.300167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:01.91558Z","time spent":"384.582056ms","remote":"127.0.0.1:47242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "}
{"level":"warn","ts":"2026-08-12T17:40:02.300064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:01.822836Z","time spent":"477.176327ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5380 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-12T17:40:02.623315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.674194ms","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-08-12T17:40:02.623418Z","caller":"traceutil/trace.go:171","msg":"trace[970030910] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5389; }","duration":"182.78254ms","start":"2026-08-12T17:40:02.440612Z","end":"2026-08-12T17:40:02.623394Z","steps":["trace[970030910] 'range keys from in-memory index tree'  (duration: 182.655883ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:02.623603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.14897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:40:02.623632Z","caller":"traceutil/trace.go:171","msg":"trace[1035323389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5389; }","duration":"168.229544ms","start":"2026-08-12T17:40:02.455396Z","end":"2026-08-12T17:40:02.623625Z","steps":["trace[1035323389] 'range keys from in-memory index tree'  (duration: 168.039355ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:03.53345Z","caller":"traceutil/trace.go:171","msg":"trace[94331043] linearizableReadLoop","detail":"{readStateIndex:5593; appliedIndex:5592; }","duration":"333.305348ms","start":"2026-08-12T17:40:03.200121Z","end":"2026-08-12T17:40:03.533426Z","steps":["trace[94331043] 'read index received'  (duration: 333.110068ms)","trace[94331043] 'applied index is now lower than readState.Index'  (duration: 194.309µs)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:40:03.53359Z","caller":"traceutil/trace.go:171","msg":"trace[2130044307] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"448.716145ms","start":"2026-08-12T17:40:03.084812Z","end":"2026-08-12T17:40:03.533528Z","steps":["trace[2130044307] 'process raft request'  (duration: 448.468193ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:03.533691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.727208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-08-12T17:40:03.533703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.56067ms","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-08-12T17:40:03.53379Z","caller":"traceutil/trace.go:171","msg":"trace[1188738262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5390; }","duration":"333.695917ms","start":"2026-08-12T17:40:03.200082Z","end":"2026-08-12T17:40:03.533778Z","steps":["trace[1188738262] 'agreement among raft nodes before linearized reading'  (duration: 333.460175ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:03.533782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:03.084785Z","time spent":"448.891634ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5381 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-08-12T17:40:03.533861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:03.200064Z","time spent":"333.791362ms","remote":"127.0.0.1:56176","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":"info","ts":"2026-08-12T17:40:03.533729Z","caller":"traceutil/trace.go:171","msg":"trace[653425817] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5390; }","duration":"321.801782ms","start":"2026-08-12T17:40:03.211917Z","end":"2026-08-12T17:40:03.533719Z","steps":["trace[653425817] 'agreement among raft nodes before linearized reading'  (duration: 321.637634ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:03.533956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:03.211907Z","time spent":"322.026162ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-12T17:40:04.004209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.72267ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454759934 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5382 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-12T17:40:04.004327Z","caller":"traceutil/trace.go:171","msg":"trace[1225332731] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"465.404416ms","start":"2026-08-12T17:40:03.538892Z","end":"2026-08-12T17:40:04.004296Z","steps":["trace[1225332731] 'process raft request'  (duration: 158.513899ms)","trace[1225332731] 'compare'  (duration: 306.33377ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:04.004444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:03.538832Z","time spent":"465.534833ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5382 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-12T17:40:04.177967Z","caller":"traceutil/trace.go:171","msg":"trace[531088792] transaction","detail":"{read_only:false; response_revision:5393; number_of_response:1; }","duration":"529.924732ms","start":"2026-08-12T17:40:03.648011Z","end":"2026-08-12T17:40:04.177936Z","steps":["trace[531088792] 'process raft request'  (duration: 510.506136ms)","trace[531088792] 'compare'  (duration: 19.265339ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:04.178481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:03.647986Z","time spent":"530.404437ms","remote":"127.0.0.1:56176","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:5384 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-12T17:40:04.180033Z","caller":"traceutil/trace.go:171","msg":"trace[583706399] linearizableReadLoop","detail":"{readStateIndex:5597; appliedIndex:5595; }","duration":"232.418327ms","start":"2026-08-12T17:40:03.947594Z","end":"2026-08-12T17:40:04.180012Z","steps":["trace[583706399] 'read index received'  (duration: 210.949109ms)","trace[583706399] 'applied index is now lower than readState.Index'  (duration: 21.468048ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:40:04.180142Z","caller":"traceutil/trace.go:171","msg":"trace[1217168293] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"450.347418ms","start":"2026-08-12T17:40:03.729772Z","end":"2026-08-12T17:40:04.18012Z","steps":["trace[1217168293] 'process raft request'  (duration: 450.137128ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:04.18023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.625297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-08-12T17:40:04.180254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:03.72975Z","time spent":"450.454643ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5385 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-12T17:40:04.180271Z","caller":"traceutil/trace.go:171","msg":"trace[1720921571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5394; }","duration":"232.712581ms","start":"2026-08-12T17:40:03.947547Z","end":"2026-08-12T17:40:04.18026Z","steps":["trace[1720921571] 'agreement among raft nodes before linearized reading'  (duration: 232.542273ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:05.611537Z","caller":"traceutil/trace.go:171","msg":"trace[1940512278] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"341.716699ms","start":"2026-08-12T17:40:05.269783Z","end":"2026-08-12T17:40:05.6115Z","steps":["trace[1940512278] 'process raft request'  (duration: 277.198816ms)","trace[1940512278] 'compare'  (duration: 64.091342ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:40:05.611431Z","caller":"traceutil/trace.go:171","msg":"trace[1917237342] linearizableReadLoop","detail":"{readStateIndex:5607; appliedIndex:5606; }","duration":"270.060023ms","start":"2026-08-12T17:40:05.341346Z","end":"2026-08-12T17:40:05.611406Z","steps":["trace[1917237342] 'read index received'  (duration: 205.585463ms)","trace[1917237342] 'applied index is now lower than readState.Index'  (duration: 64.47278ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:05.61169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:05.269767Z","time spent":"341.842656ms","remote":"127.0.0.1:55932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.136\" mod_revision:5351 > success:<request_put:<key:\"/registry/masterleases/199.19.213.136\" value_size:67 lease:5036607641599984155 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.136\" > >"}
{"level":"warn","ts":"2026-08-12T17:40:05.611919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.559109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-08-12T17:40:05.611981Z","caller":"traceutil/trace.go:171","msg":"trace[456839211] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5403; }","duration":"270.660533ms","start":"2026-08-12T17:40:05.341305Z","end":"2026-08-12T17:40:05.611966Z","steps":["trace[456839211] 'agreement among raft nodes before linearized reading'  (duration: 270.430362ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:05.61273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.821719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:40:05.612803Z","caller":"traceutil/trace.go:171","msg":"trace[823371375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5403; }","duration":"155.016409ms","start":"2026-08-12T17:40:05.457768Z","end":"2026-08-12T17:40:05.612785Z","steps":["trace[823371375] 'agreement among raft nodes before linearized reading'  (duration: 154.02358ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:05.997449Z","caller":"traceutil/trace.go:171","msg":"trace[205592203] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"380.871021ms","start":"2026-08-12T17:40:05.616549Z","end":"2026-08-12T17:40:05.99742Z","steps":["trace[205592203] 'process raft request'  (duration: 311.622474ms)","trace[205592203] 'compare'  (duration: 69.127261ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:05.997619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:05.616533Z","time spent":"380.994867ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5390 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-12T17:40:06.027498Z","caller":"traceutil/trace.go:171","msg":"trace[980034337] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"410.448541ms","start":"2026-08-12T17:40:05.61703Z","end":"2026-08-12T17:40:06.027479Z","steps":["trace[980034337] 'process raft request'  (duration: 410.370707ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.027619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:05.617022Z","time spent":"410.538895ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:5306 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-08-12T17:40:06.027731Z","caller":"traceutil/trace.go:171","msg":"trace[1398446825] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"241.898046ms","start":"2026-08-12T17:40:05.785816Z","end":"2026-08-12T17:40:06.027714Z","steps":["trace[1398446825] 'process raft request'  (duration: 241.628073ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:06.027815Z","caller":"traceutil/trace.go:171","msg":"trace[1723014764] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"410.920524ms","start":"2026-08-12T17:40:05.616883Z","end":"2026-08-12T17:40:06.027803Z","steps":["trace[1723014764] 'process raft request'  (duration: 410.389568ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.027869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:05.616857Z","time spent":"410.981628ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5391 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-12T17:40:06.028111Z","caller":"traceutil/trace.go:171","msg":"trace[2147018684] linearizableReadLoop","detail":"{readStateIndex:5610; appliedIndex:5607; }","duration":"410.533726ms","start":"2026-08-12T17:40:05.617563Z","end":"2026-08-12T17:40:06.028097Z","steps":["trace[2147018684] 'read index received'  (duration: 310.618845ms)","trace[2147018684] 'applied index is now lower than readState.Index'  (duration: 99.913261ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:40:06.028151Z","caller":"traceutil/trace.go:171","msg":"trace[759557787] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"106.725888ms","start":"2026-08-12T17:40:05.921387Z","end":"2026-08-12T17:40:06.028113Z","steps":["trace[759557787] 'process raft request'  (duration: 106.270765ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.028285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.706224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-08-12T17:40:06.028307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.65787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-db-init-fs4bf\" ","response":"range_response_count:1 size:7347"}
{"level":"info","ts":"2026-08-12T17:40:06.028341Z","caller":"traceutil/trace.go:171","msg":"trace[469360469] range","detail":"{range_begin:/registry/pods/openstack/keystone-db-init-fs4bf; range_end:; response_count:1; response_revision:5408; }","duration":"264.734853ms","start":"2026-08-12T17:40:05.763596Z","end":"2026-08-12T17:40:06.028331Z","steps":["trace[469360469] 'agreement among raft nodes before linearized reading'  (duration: 264.586456ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:06.028338Z","caller":"traceutil/trace.go:171","msg":"trace[1315642752] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5408; }","duration":"410.791258ms","start":"2026-08-12T17:40:05.617533Z","end":"2026-08-12T17:40:06.028325Z","steps":["trace[1315642752] 'agreement among raft nodes before linearized reading'  (duration: 410.612189ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.028439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:05.617524Z","time spent":"410.876333ms","remote":"127.0.0.1:56184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"info","ts":"2026-08-12T17:40:06.363428Z","caller":"traceutil/trace.go:171","msg":"trace[117451861] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"330.592364ms","start":"2026-08-12T17:40:06.032801Z","end":"2026-08-12T17:40:06.363394Z","steps":["trace[117451861] 'process raft request'  (duration: 330.1066ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.363607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.032772Z","time spent":"330.743311ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5392 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-12T17:40:06.60378Z","caller":"traceutil/trace.go:171","msg":"trace[79818549] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"566.92082ms","start":"2026-08-12T17:40:06.036823Z","end":"2026-08-12T17:40:06.603744Z","steps":["trace[79818549] 'process raft request'  (duration: 566.666147ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:06.60383Z","caller":"traceutil/trace.go:171","msg":"trace[1818732086] linearizableReadLoop","detail":"{readStateIndex:5616; appliedIndex:5613; }","duration":"403.822472ms","start":"2026-08-12T17:40:06.199985Z","end":"2026-08-12T17:40:06.603807Z","steps":["trace[1818732086] 'read index received'  (duration: 163.497598ms)","trace[1818732086] 'applied index is now lower than readState.Index'  (duration: 240.323824ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:06.603944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.036802Z","time spent":"567.059346ms","remote":"127.0.0.1:56072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7277,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/keystone-db-init-fs4bf\" mod_revision:5360 > success:<request_put:<key:\"/registry/pods/openstack/keystone-db-init-fs4bf\" value_size:7222 >> failure:<request_range:<key:\"/registry/pods/openstack/keystone-db-init-fs4bf\" > >"}
{"level":"info","ts":"2026-08-12T17:40:06.604075Z","caller":"traceutil/trace.go:171","msg":"trace[700175624] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"246.548901ms","start":"2026-08-12T17:40:06.35751Z","end":"2026-08-12T17:40:06.604059Z","steps":["trace[700175624] 'process raft request'  (duration: 246.250366ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:06.604205Z","caller":"traceutil/trace.go:171","msg":"trace[126168595] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"419.842273ms","start":"2026-08-12T17:40:06.184354Z","end":"2026-08-12T17:40:06.604196Z","steps":["trace[126168595] 'process raft request'  (duration: 419.36871ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.604228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.134294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-12T17:40:06.604278Z","caller":"traceutil/trace.go:171","msg":"trace[921662091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5413; }","duration":"223.238749ms","start":"2026-08-12T17:40:06.381026Z","end":"2026-08-12T17:40:06.604264Z","steps":["trace[921662091] 'agreement among raft nodes before linearized reading'  (duration: 223.072811ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.604294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.184344Z","time spent":"419.888586ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5394 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-12T17:40:06.604334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.357748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-12T17:40:06.604383Z","caller":"traceutil/trace.go:171","msg":"trace[51896402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5413; }","duration":"404.445293ms","start":"2026-08-12T17:40:06.199931Z","end":"2026-08-12T17:40:06.604376Z","steps":["trace[51896402] 'agreement among raft nodes before linearized reading'  (duration: 404.304096ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:06.604471Z","caller":"traceutil/trace.go:171","msg":"trace[1935774849] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"420.237403ms","start":"2026-08-12T17:40:06.183981Z","end":"2026-08-12T17:40:06.604219Z","steps":["trace[1935774849] 'process raft request'  (duration: 419.682756ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.604545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.267346ms","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-08-12T17:40:06.60468Z","caller":"traceutil/trace.go:171","msg":"trace[682320895] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5413; }","duration":"214.443005ms","start":"2026-08-12T17:40:06.39022Z","end":"2026-08-12T17:40:06.604663Z","steps":["trace[682320895] 'agreement among raft nodes before linearized reading'  (duration: 214.023144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:06.604487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.199915Z","time spent":"404.481604ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-12T17:40:06.604964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.183955Z","time spent":"420.686305ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5393 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-12T17:40:07.179126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.383518ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259979678454759985 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5395 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-12T17:40:07.179326Z","caller":"traceutil/trace.go:171","msg":"trace[1590445097] linearizableReadLoop","detail":"{readStateIndex:5620; appliedIndex:5617; }","duration":"191.205708ms","start":"2026-08-12T17:40:06.9881Z","end":"2026-08-12T17:40:07.179305Z","steps":["trace[1590445097] 'read index received'  (duration: 55.522µs)","trace[1590445097] 'applied index is now lower than readState.Index'  (duration: 191.149106ms)"],"step_count":2}
{"level":"info","ts":"2026-08-12T17:40:07.179422Z","caller":"traceutil/trace.go:171","msg":"trace[1732489495] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"567.366974ms","start":"2026-08-12T17:40:06.612044Z","end":"2026-08-12T17:40:07.179411Z","steps":["trace[1732489495] 'process raft request'  (duration: 567.222426ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:07.179484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.612037Z","time spent":"567.414817ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5398 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-12T17:40:07.179611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.513334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:40:07.179641Z","caller":"traceutil/trace.go:171","msg":"trace[1192790145] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5416; }","duration":"191.579638ms","start":"2026-08-12T17:40:06.988054Z","end":"2026-08-12T17:40:07.179633Z","steps":["trace[1192790145] 'agreement among raft nodes before linearized reading'  (duration: 191.529795ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:07.179819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.678202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-12T17:40:07.179853Z","caller":"traceutil/trace.go:171","msg":"trace[1874912008] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5416; }","duration":"191.733985ms","start":"2026-08-12T17:40:06.988111Z","end":"2026-08-12T17:40:07.179845Z","steps":["trace[1874912008] 'agreement among raft nodes before linearized reading'  (duration: 191.687653ms)"],"step_count":1}
{"level":"info","ts":"2026-08-12T17:40:07.179893Z","caller":"traceutil/trace.go:171","msg":"trace[620681234] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"568.221366ms","start":"2026-08-12T17:40:06.611645Z","end":"2026-08-12T17:40:07.179867Z","steps":["trace[620681234] 'process raft request'  (duration: 73.018688ms)","trace[620681234] 'compare'  (duration: 494.267792ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-12T17:40:07.180033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.611627Z","time spent":"568.335492ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5395 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-08-12T17:40:07.180234Z","caller":"traceutil/trace.go:171","msg":"trace[340622294] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"567.637527ms","start":"2026-08-12T17:40:06.611758Z","end":"2026-08-12T17:40:07.179396Z","steps":["trace[340622294] 'process raft request'  (duration: 567.462668ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-12T17:40:07.180374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:40:06.61173Z","time spent":"568.573164ms","remote":"127.0.0.1:56176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5397 > 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-08-12T17:40:32.271491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2917}
{"level":"info","ts":"2026-08-12T17:40:32.361215Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2917,"took":"88.404032ms","hash":1762224558,"current-db-size-bytes":53448704,"current-db-size":"53 MB","current-db-size-in-use-bytes":29265920,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-12T17:40:32.361286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1762224558,"revision":2917,"compact-revision":-1}
{"level":"info","ts":"2026-08-12T17:45:32.277605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5598}
{"level":"info","ts":"2026-08-12T17:45:32.36077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5598,"took":"81.932651ms","hash":4268255333,"current-db-size-bytes":53448704,"current-db-size":"53 MB","current-db-size-in-use-bytes":18247680,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-08-12T17:45:32.360831Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4268255333,"revision":5598,"compact-revision":2917}