{"level":"warn","ts":"2026-08-24T20:43:04.174194Z","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-24T20:43:04.174301Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-24T20:43:04.174498Z","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-24T20:43:04.174518Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]}
{"level":"info","ts":"2026-08-24T20:43:04.174538Z","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-24T20:43:04.175563Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]}
{"level":"info","ts":"2026-08-24T20:43:04.175727Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-24T20:43:04.178853Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.828758ms"}
{"level":"info","ts":"2026-08-24T20:43:04.185711Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"}
{"level":"info","ts":"2026-08-24T20:43:04.185902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-24T20:43:04.185962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"}
{"level":"info","ts":"2026-08-24T20:43:04.186016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-24T20:43:04.186059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"}
{"level":"info","ts":"2026-08-24T20:43:04.186191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"}
{"level":"warn","ts":"2026-08-24T20:43:04.190684Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-24T20:43:04.192969Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-24T20:43:04.19456Z","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-24T20:43:04.197186Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-24T20:43:04.197408Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-24T20:43:04.197561Z","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-24T20:43:04.197718Z","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-24T20:43:04.197738Z","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-24T20:43:04.198379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"}
{"level":"info","ts":"2026-08-24T20:43:04.198524Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]}
{"level":"info","ts":"2026-08-24T20:43:04.200896Z","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-24T20:43:04.201004Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"}
{"level":"info","ts":"2026-08-24T20:43:04.201056Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"}
{"level":"info","ts":"2026-08-24T20:43:04.201161Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-24T20:43:04.201222Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-24T20:43:04.48665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-24T20:43:04.486725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-24T20:43:04.486748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"}
{"level":"info","ts":"2026-08-24T20:43:04.486767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"}
{"level":"info","ts":"2026-08-24T20:43:04.486778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"}
{"level":"info","ts":"2026-08-24T20:43:04.486794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"}
{"level":"info","ts":"2026-08-24T20:43:04.486807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"}
{"level":"info","ts":"2026-08-24T20:43:04.487573Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-24T20:43:04.488283Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-24T20:43:04.488284Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-24T20:43:04.488372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-24T20:43:04.488616Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-24T20:43:04.488713Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-24T20:43:04.488806Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-24T20:43:04.488844Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-24T20:43:04.488732Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-24T20:43:04.491384Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-24T20:43:04.492609Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"}
{"level":"info","ts":"2026-08-24T20:43:06.989486Z","caller":"traceutil/trace.go:171","msg":"trace[996043807] linearizableReadLoop","detail":"{readStateIndex:131; appliedIndex:130; }","duration":"193.522246ms","start":"2026-08-24T20:43:06.795929Z","end":"2026-08-24T20:43:06.989451Z","steps":["trace[996043807] 'read index received'  (duration: 185.599686ms)","trace[996043807] 'applied index is now lower than readState.Index'  (duration: 7.91879ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:43:06.989553Z","caller":"traceutil/trace.go:171","msg":"trace[11009476] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"196.817265ms","start":"2026-08-24T20:43:06.792706Z","end":"2026-08-24T20:43:06.989523Z","steps":["trace[11009476] 'process raft request'  (duration: 188.879615ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:06.989704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.777104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-08-24T20:43:06.989813Z","caller":"traceutil/trace.go:171","msg":"trace[1992800534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:126; }","duration":"193.954108ms","start":"2026-08-24T20:43:06.795843Z","end":"2026-08-24T20:43:06.989797Z","steps":["trace[1992800534] 'agreement among raft nodes before linearized reading'  (duration: 193.751052ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:43:19.6389Z","caller":"traceutil/trace.go:171","msg":"trace[1684845941] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"355.814392ms","start":"2026-08-24T20:43:19.283068Z","end":"2026-08-24T20:43:19.638882Z","steps":["trace[1684845941] 'process raft request'  (duration: 355.676049ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:19.639442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:43:19.283043Z","time spent":"355.923955ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:401 > 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-24T20:43:19.65119Z","caller":"traceutil/trace.go:171","msg":"trace[1673629218] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"136.81468ms","start":"2026-08-24T20:43:19.514343Z","end":"2026-08-24T20:43:19.651158Z","steps":["trace[1673629218] 'process raft request'  (duration: 136.681596ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:20.019091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.490603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"}
{"level":"info","ts":"2026-08-24T20:43:20.019171Z","caller":"traceutil/trace.go:171","msg":"trace[1844789557] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:407; }","duration":"115.618836ms","start":"2026-08-24T20:43:19.903538Z","end":"2026-08-24T20:43:20.019157Z","steps":["trace[1844789557] 'range keys from in-memory index tree'  (duration: 115.37889ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:20.019313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.572394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-24T20:43:20.019382Z","caller":"traceutil/trace.go:171","msg":"trace[1268097949] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:407; }","duration":"150.692586ms","start":"2026-08-24T20:43:19.868673Z","end":"2026-08-24T20:43:20.019366Z","steps":["trace[1268097949] 'range keys from in-memory index tree'  (duration: 150.337868ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:43:20.179811Z","caller":"traceutil/trace.go:171","msg":"trace[38157885] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"156.551708ms","start":"2026-08-24T20:43:20.023238Z","end":"2026-08-24T20:43:20.179789Z","steps":["trace[38157885] 'process raft request'  (duration: 156.251051ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:43:20.380952Z","caller":"traceutil/trace.go:171","msg":"trace[1706778150] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"218.983902ms","start":"2026-08-24T20:43:20.161945Z","end":"2026-08-24T20:43:20.380929Z","steps":["trace[1706778150] 'read index received'  (duration: 17.539935ms)","trace[1706778150] 'applied index is now lower than readState.Index'  (duration: 201.442987ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:43:20.38107Z","caller":"traceutil/trace.go:171","msg":"trace[1277323158] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"355.045754ms","start":"2026-08-24T20:43:20.025983Z","end":"2026-08-24T20:43:20.381029Z","steps":["trace[1277323158] 'process raft request'  (duration: 354.823088ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:20.381136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.156617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-24T20:43:20.381165Z","caller":"traceutil/trace.go:171","msg":"trace[689371140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:409; }","duration":"219.26596ms","start":"2026-08-24T20:43:20.16189Z","end":"2026-08-24T20:43:20.381156Z","steps":["trace[689371140] 'agreement among raft nodes before linearized reading'  (duration: 219.167487ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:20.381236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:43:20.025966Z","time spent":"355.188548ms","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:322 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6883 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"info","ts":"2026-08-24T20:43:47.532777Z","caller":"traceutil/trace.go:171","msg":"trace[1932873864] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"140.038527ms","start":"2026-08-24T20:43:47.39271Z","end":"2026-08-24T20:43:47.532748Z","steps":["trace[1932873864] 'process raft request'  (duration: 139.876453ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:43:48.041611Z","caller":"traceutil/trace.go:171","msg":"trace[1252809557] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"263.214006ms","start":"2026-08-24T20:43:47.778378Z","end":"2026-08-24T20:43:48.041592Z","steps":["trace[1252809557] 'read index received'  (duration: 262.548429ms)","trace[1252809557] 'applied index is now lower than readState.Index'  (duration: 661.637µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:43:48.041677Z","caller":"traceutil/trace.go:171","msg":"trace[1963938544] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"271.679241ms","start":"2026-08-24T20:43:47.769959Z","end":"2026-08-24T20:43:48.041639Z","steps":["trace[1963938544] 'process raft request'  (duration: 271.186209ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:48.041767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.040547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-08-24T20:43:48.041798Z","caller":"traceutil/trace.go:171","msg":"trace[2017848690] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:623; }","duration":"241.12624ms","start":"2026-08-24T20:43:47.800664Z","end":"2026-08-24T20:43:48.04179Z","steps":["trace[2017848690] 'agreement among raft nodes before linearized reading'  (duration: 241.051498ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:43:48.041993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.579664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-24T20:43:48.042098Z","caller":"traceutil/trace.go:171","msg":"trace[239302265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"263.739548ms","start":"2026-08-24T20:43:47.778335Z","end":"2026-08-24T20:43:48.042075Z","steps":["trace[239302265] 'agreement among raft nodes before linearized reading'  (duration: 263.366339ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:43:48.679273Z","caller":"traceutil/trace.go:171","msg":"trace[629263477] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"104.889115ms","start":"2026-08-24T20:43:48.574358Z","end":"2026-08-24T20:43:48.679247Z","steps":["trace[629263477] 'process raft request'  (duration: 104.740641ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:44:29.782701Z","caller":"traceutil/trace.go:171","msg":"trace[795317020] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"162.233496ms","start":"2026-08-24T20:44:29.620442Z","end":"2026-08-24T20:44:29.782675Z","steps":["trace[795317020] 'process raft request'  (duration: 162.099893ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:45:13.76456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.266806ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438305424 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1758 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-24T20:45:13.764655Z","caller":"traceutil/trace.go:171","msg":"trace[1528564884] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1892; }","duration":"288.652371ms","start":"2026-08-24T20:45:13.475991Z","end":"2026-08-24T20:45:13.764643Z","steps":["trace[1528564884] 'read index received'  (duration: 53.541µs)","trace[1528564884] 'applied index is now lower than readState.Index'  (duration: 288.5979ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:45:13.764706Z","caller":"traceutil/trace.go:171","msg":"trace[1269850791] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"345.271815ms","start":"2026-08-24T20:45:13.419401Z","end":"2026-08-24T20:45:13.764673Z","steps":["trace[1269850791] 'process raft request'  (duration: 43.715733ms)","trace[1269850791] 'compare'  (duration: 301.154372ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:45:13.764854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:45:13.41939Z","time spent":"345.392157ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1758 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-24T20:45:13.764911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.337312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-24T20:45:13.764952Z","caller":"traceutil/trace.go:171","msg":"trace[1340946500] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1836; }","duration":"180.407224ms","start":"2026-08-24T20:45:13.584528Z","end":"2026-08-24T20:45:13.764936Z","steps":["trace[1340946500] 'agreement among raft nodes before linearized reading'  (duration: 180.357343ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:45:13.764747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.765354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-24T20:45:13.765035Z","caller":"traceutil/trace.go:171","msg":"trace[159324930] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1836; }","duration":"289.084611ms","start":"2026-08-24T20:45:13.475938Z","end":"2026-08-24T20:45:13.765022Z","steps":["trace[159324930] 'agreement among raft nodes before linearized reading'  (duration: 288.775943ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:45:13.764841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.646087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-24T20:45:13.765212Z","caller":"traceutil/trace.go:171","msg":"trace[611726720] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1836; }","duration":"261.030405ms","start":"2026-08-24T20:45:13.504135Z","end":"2026-08-24T20:45:13.765165Z","steps":["trace[611726720] 'agreement among raft nodes before linearized reading'  (duration: 260.631946ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:45:56.8044Z","caller":"traceutil/trace.go:171","msg":"trace[15592389] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"120.971893ms","start":"2026-08-24T20:45:56.683401Z","end":"2026-08-24T20:45:56.804373Z","steps":["trace[15592389] 'process raft request'  (duration: 117.282473ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:48:00.693375Z","caller":"traceutil/trace.go:171","msg":"trace[913611783] linearizableReadLoop","detail":"{readStateIndex:3377; appliedIndex:3376; }","duration":"121.4521ms","start":"2026-08-24T20:48:00.571903Z","end":"2026-08-24T20:48:00.693355Z","steps":["trace[913611783] 'read index received'  (duration: 121.312027ms)","trace[913611783] 'applied index is now lower than readState.Index'  (duration: 139.003µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:48:00.693533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.629614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-08-24T20:48:00.693469Z","caller":"traceutil/trace.go:171","msg":"trace[1671624215] transaction","detail":"{read_only:false; response_revision:3248; number_of_response:1; }","duration":"172.49182ms","start":"2026-08-24T20:48:00.520921Z","end":"2026-08-24T20:48:00.693413Z","steps":["trace[1671624215] 'process raft request'  (duration: 172.299665ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:48:00.693559Z","caller":"traceutil/trace.go:171","msg":"trace[1244357004] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:3248; }","duration":"121.671615ms","start":"2026-08-24T20:48:00.571879Z","end":"2026-08-24T20:48:00.693551Z","steps":["trace[1244357004] 'agreement among raft nodes before linearized reading'  (duration: 121.551392ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:49:18.187104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.79668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/loki\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-24T20:49:18.187202Z","caller":"traceutil/trace.go:171","msg":"trace[223070961] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/loki; range_end:; response_count:0; response_revision:4325; }","duration":"226.940334ms","start":"2026-08-24T20:49:17.960241Z","end":"2026-08-24T20:49:18.187181Z","steps":["trace[223070961] 'range keys from in-memory index tree'  (duration: 226.732269ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:49:21.623321Z","caller":"traceutil/trace.go:171","msg":"trace[1939810683] transaction","detail":"{read_only:false; response_revision:4474; number_of_response:1; }","duration":"152.880964ms","start":"2026-08-24T20:49:21.470404Z","end":"2026-08-24T20:49:21.623285Z","steps":["trace[1939810683] 'process raft request'  (duration: 152.691799ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:49:36.06817Z","caller":"traceutil/trace.go:171","msg":"trace[707580736] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"106.927918ms","start":"2026-08-24T20:49:35.961151Z","end":"2026-08-24T20:49:36.068079Z","steps":["trace[707580736] 'process raft request'  (duration: 106.758264ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:49:36.069205Z","caller":"traceutil/trace.go:171","msg":"trace[1624057840] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"104.227083ms","start":"2026-08-24T20:49:35.964929Z","end":"2026-08-24T20:49:36.069156Z","steps":["trace[1624057840] 'process raft request'  (duration: 104.046278ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:49:42.541358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.474347ms","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-24T20:49:42.541743Z","caller":"traceutil/trace.go:171","msg":"trace[1822268661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4928; }","duration":"176.870088ms","start":"2026-08-24T20:49:42.364857Z","end":"2026-08-24T20:49:42.541728Z","steps":["trace[1822268661] 'range keys from in-memory index tree'  (duration: 176.269532ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:49:42.541633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.1433ms","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-24T20:49:42.541912Z","caller":"traceutil/trace.go:171","msg":"trace[320569863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4928; }","duration":"124.477819ms","start":"2026-08-24T20:49:42.417411Z","end":"2026-08-24T20:49:42.541888Z","steps":["trace[320569863] 'range keys from in-memory index tree'  (duration: 123.943425ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:49:42.71318Z","caller":"traceutil/trace.go:171","msg":"trace[504613620] linearizableReadLoop","detail":"{readStateIndex:5134; appliedIndex:5132; }","duration":"162.273167ms","start":"2026-08-24T20:49:42.550876Z","end":"2026-08-24T20:49:42.713149Z","steps":["trace[504613620] 'read index received'  (duration: 79.151018ms)","trace[504613620] 'applied index is now lower than readState.Index'  (duration: 83.121179ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:49:42.713322Z","caller":"traceutil/trace.go:171","msg":"trace[502750782] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"167.424778ms","start":"2026-08-24T20:49:42.545862Z","end":"2026-08-24T20:49:42.713286Z","steps":["trace[502750782] 'process raft request'  (duration: 131.679211ms)","trace[502750782] 'compare'  (duration: 35.43877ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:49:42.713443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.557925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10933a89-7f22-41d9-bae8-c25bccccbbe1\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-08-24T20:49:42.713508Z","caller":"traceutil/trace.go:171","msg":"trace[217465121] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-10933a89-7f22-41d9-bae8-c25bccccbbe1; range_end:; response_count:1; response_revision:4930; }","duration":"162.665837ms","start":"2026-08-24T20:49:42.550825Z","end":"2026-08-24T20:49:42.713491Z","steps":["trace[217465121] 'agreement among raft nodes before linearized reading'  (duration: 162.478512ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:53:04.526291Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3277}
{"level":"info","ts":"2026-08-24T20:53:04.619389Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3277,"took":"91.081203ms","hash":998785447,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":34529280,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-24T20:53:04.619467Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":998785447,"revision":3277,"compact-revision":-1}
{"level":"info","ts":"2026-08-24T20:55:31.210464Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002116.wal"}
{"level":"info","ts":"2026-08-24T20:55:35.222965Z","caller":"traceutil/trace.go:171","msg":"trace[1203550772] transaction","detail":"{read_only:false; response_revision:8141; number_of_response:1; }","duration":"262.918318ms","start":"2026-08-24T20:55:34.960012Z","end":"2026-08-24T20:55:35.22293Z","steps":["trace[1203550772] 'process raft request'  (duration: 262.585909ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:55:47.319234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.305662ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438322085 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8206 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-24T20:55:47.31937Z","caller":"traceutil/trace.go:171","msg":"trace[1247423039] linearizableReadLoop","detail":"{readStateIndex:8581; appliedIndex:8580; }","duration":"186.691843ms","start":"2026-08-24T20:55:47.132657Z","end":"2026-08-24T20:55:47.319349Z","steps":["trace[1247423039] 'read index received'  (duration: 80.062µs)","trace[1247423039] 'applied index is now lower than readState.Index'  (duration: 186.609831ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:55:47.319446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.799475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-24T20:55:47.319477Z","caller":"traceutil/trace.go:171","msg":"trace[1721394904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8219; }","duration":"186.830266ms","start":"2026-08-24T20:55:47.132637Z","end":"2026-08-24T20:55:47.319467Z","steps":["trace[1721394904] 'agreement among raft nodes before linearized reading'  (duration: 186.766794ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:55:47.319516Z","caller":"traceutil/trace.go:171","msg":"trace[331347697] transaction","detail":"{read_only:false; response_revision:8219; number_of_response:1; }","duration":"486.623845ms","start":"2026-08-24T20:55:46.83281Z","end":"2026-08-24T20:55:47.319434Z","steps":["trace[331347697] 'process raft request'  (duration: 84.010796ms)","trace[331347697] 'compare'  (duration: 401.597955ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:55:47.319996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:55:46.832786Z","time spent":"486.917883ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":552,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8206 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-24T20:55:47.319968Z","caller":"traceutil/trace.go:171","msg":"trace[5702915] transaction","detail":"{read_only:false; response_revision:8220; number_of_response:1; }","duration":"131.794836ms","start":"2026-08-24T20:55:47.188142Z","end":"2026-08-24T20:55:47.319937Z","steps":["trace[5702915] 'process raft request'  (duration: 131.600092ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:55:47.93141Z","caller":"traceutil/trace.go:171","msg":"trace[295467678] transaction","detail":"{read_only:false; response_revision:8226; number_of_response:1; }","duration":"119.309779ms","start":"2026-08-24T20:55:47.81207Z","end":"2026-08-24T20:55:47.93138Z","steps":["trace[295467678] 'process raft request'  (duration: 119.083724ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:55:48.040076Z","caller":"traceutil/trace.go:171","msg":"trace[649882805] linearizableReadLoop","detail":"{readStateIndex:8589; appliedIndex:8587; }","duration":"201.07972ms","start":"2026-08-24T20:55:47.83896Z","end":"2026-08-24T20:55:48.040039Z","steps":["trace[649882805] 'read index received'  (duration: 92.22314ms)","trace[649882805] 'applied index is now lower than readState.Index'  (duration: 108.85506ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:55:48.040384Z","caller":"traceutil/trace.go:171","msg":"trace[938351834] transaction","detail":"{read_only:false; response_revision:8227; number_of_response:1; }","duration":"225.858533ms","start":"2026-08-24T20:55:47.81449Z","end":"2026-08-24T20:55:48.040348Z","steps":["trace[938351834] 'process raft request'  (duration: 199.933521ms)","trace[938351834] 'compare'  (duration: 25.4762ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:55:48.040541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.577972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-08-24T20:55:48.04062Z","caller":"traceutil/trace.go:171","msg":"trace[1048693760] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:8227; }","duration":"201.712345ms","start":"2026-08-24T20:55:47.838889Z","end":"2026-08-24T20:55:48.040601Z","steps":["trace[1048693760] 'agreement among raft nodes before linearized reading'  (duration: 201.422528ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:56:15.699334Z","caller":"traceutil/trace.go:171","msg":"trace[1169149231] transaction","detail":"{read_only:false; response_revision:8461; number_of_response:1; }","duration":"329.593841ms","start":"2026-08-24T20:56:15.369712Z","end":"2026-08-24T20:56:15.699305Z","steps":["trace[1169149231] 'process raft request'  (duration: 329.451768ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:56:15.699584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:56:15.369682Z","time spent":"329.761585ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:8344 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-08-24T20:56:15.700135Z","caller":"traceutil/trace.go:171","msg":"trace[1098771969] linearizableReadLoop","detail":"{readStateIndex:8836; appliedIndex:8836; }","duration":"138.168216ms","start":"2026-08-24T20:56:15.561919Z","end":"2026-08-24T20:56:15.700087Z","steps":["trace[1098771969] 'read index received'  (duration: 138.159095ms)","trace[1098771969] 'applied index is now lower than readState.Index'  (duration: 7.741µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:56:15.700378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.449024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-08-24T20:56:15.700673Z","caller":"traceutil/trace.go:171","msg":"trace[432478793] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8461; }","duration":"138.794532ms","start":"2026-08-24T20:56:15.561863Z","end":"2026-08-24T20:56:15.700658Z","steps":["trace[432478793] 'agreement among raft nodes before linearized reading'  (duration: 138.378492ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:56:15.822519Z","caller":"traceutil/trace.go:171","msg":"trace[640333692] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"189.028685ms","start":"2026-08-24T20:56:15.633455Z","end":"2026-08-24T20:56:15.822484Z","steps":["trace[640333692] 'process raft request'  (duration: 188.765418ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:56:15.822806Z","caller":"traceutil/trace.go:171","msg":"trace[570507396] linearizableReadLoop","detail":"{readStateIndex:8838; appliedIndex:8836; }","duration":"122.493721ms","start":"2026-08-24T20:56:15.700191Z","end":"2026-08-24T20:56:15.822685Z","steps":["trace[570507396] 'read index received'  (duration: 122.043859ms)","trace[570507396] 'applied index is now lower than readState.Index'  (duration: 447.302µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T20:56:15.82298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.981395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-865cbb895d-6kdnz.18ced935714973ce\" ","response":"range_response_count:1 size:1135"}
{"level":"info","ts":"2026-08-24T20:56:15.82306Z","caller":"traceutil/trace.go:171","msg":"trace[166691740] range","detail":"{range_begin:/registry/events/openstack/barbican-api-865cbb895d-6kdnz.18ced935714973ce; range_end:; response_count:1; response_revision:8463; }","duration":"150.131819ms","start":"2026-08-24T20:56:15.672907Z","end":"2026-08-24T20:56:15.823039Z","steps":["trace[166691740] 'agreement among raft nodes before linearized reading'  (duration: 149.866672ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:56:15.82319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.258553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-08-24T20:56:15.823239Z","caller":"traceutil/trace.go:171","msg":"trace[545192482] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8463; }","duration":"186.376116ms","start":"2026-08-24T20:56:15.636848Z","end":"2026-08-24T20:56:15.823224Z","steps":["trace[545192482] 'agreement among raft nodes before linearized reading'  (duration: 186.081359ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:56:15.823301Z","caller":"traceutil/trace.go:171","msg":"trace[1326302305] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"126.014149ms","start":"2026-08-24T20:56:15.69727Z","end":"2026-08-24T20:56:15.823284Z","steps":["trace[1326302305] 'process raft request'  (duration: 125.139757ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:56:15.823522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.998537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-24T20:56:15.823697Z","caller":"traceutil/trace.go:171","msg":"trace[1852643292] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8463; }","duration":"218.241423ms","start":"2026-08-24T20:56:15.605427Z","end":"2026-08-24T20:56:15.823669Z","steps":["trace[1852643292] 'agreement among raft nodes before linearized reading'  (duration: 217.828123ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:56:15.823759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.176081ms","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-24T20:56:15.823823Z","caller":"traceutil/trace.go:171","msg":"trace[1076931528] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8463; }","duration":"250.261393ms","start":"2026-08-24T20:56:15.573546Z","end":"2026-08-24T20:56:15.823808Z","steps":["trace[1076931528] 'agreement among raft nodes before linearized reading'  (duration: 250.095179ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:56:15.824169Z","caller":"traceutil/trace.go:171","msg":"trace[864913545] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"120.578522ms","start":"2026-08-24T20:56:15.703581Z","end":"2026-08-24T20:56:15.824159Z","steps":["trace[864913545] 'process raft request'  (duration: 120.306964ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:56:30.094852Z","caller":"traceutil/trace.go:171","msg":"trace[607142099] transaction","detail":"{read_only:false; response_revision:8603; number_of_response:1; }","duration":"157.25629ms","start":"2026-08-24T20:56:29.937568Z","end":"2026-08-24T20:56:30.094824Z","steps":["trace[607142099] 'process raft request'  (duration: 143.969033ms)","trace[607142099] 'compare'  (duration: 13.085292ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:56:31.550716Z","caller":"traceutil/trace.go:171","msg":"trace[1524579056] transaction","detail":"{read_only:false; response_revision:8613; number_of_response:1; }","duration":"198.801371ms","start":"2026-08-24T20:56:31.351865Z","end":"2026-08-24T20:56:31.550666Z","steps":["trace[1524579056] 'process raft request'  (duration: 198.575986ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:57:45.46731Z","caller":"traceutil/trace.go:171","msg":"trace[900390304] linearizableReadLoop","detail":"{readStateIndex:9806; appliedIndex:9805; }","duration":"117.120505ms","start":"2026-08-24T20:57:45.350163Z","end":"2026-08-24T20:57:45.467283Z","steps":["trace[900390304] 'read index received'  (duration: 116.888939ms)","trace[900390304] 'applied index is now lower than readState.Index'  (duration: 230.486µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:57:45.467426Z","caller":"traceutil/trace.go:171","msg":"trace[1922597031] transaction","detail":"{read_only:false; response_revision:9387; number_of_response:1; }","duration":"188.545607ms","start":"2026-08-24T20:57:45.278851Z","end":"2026-08-24T20:57:45.467396Z","steps":["trace[1922597031] 'process raft request'  (duration: 188.27396ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T20:57:45.467561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.379361ms","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-24T20:57:45.467608Z","caller":"traceutil/trace.go:171","msg":"trace[2116224906] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9387; }","duration":"117.491803ms","start":"2026-08-24T20:57:45.350104Z","end":"2026-08-24T20:57:45.467596Z","steps":["trace[2116224906] 'agreement among raft nodes before linearized reading'  (duration: 117.304869ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T20:57:45.573045Z","caller":"traceutil/trace.go:171","msg":"trace[61790879] transaction","detail":"{read_only:false; response_revision:9388; number_of_response:1; }","duration":"100.20379ms","start":"2026-08-24T20:57:45.472805Z","end":"2026-08-24T20:57:45.573009Z","steps":["trace[61790879] 'process raft request'  (duration: 17.865159ms)","trace[61790879] 'compare'  (duration: 82.196207ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T20:58:04.53442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6672}
{"level":"info","ts":"2026-08-24T20:58:04.632295Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6672,"took":"95.192066ms","hash":1601281452,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":27287552,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-24T20:58:04.632371Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1601281452,"revision":6672,"compact-revision":3277}
{"level":"info","ts":"2026-08-24T20:58:05.201349Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"11f26225a5bb9fe3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-24T20:58:05.206628Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-24T20:58:05.206795Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-24T21:00:04.706491Z","caller":"traceutil/trace.go:171","msg":"trace[457129212] transaction","detail":"{read_only:false; response_revision:10695; number_of_response:1; }","duration":"135.14227ms","start":"2026-08-24T21:00:04.571311Z","end":"2026-08-24T21:00:04.706453Z","steps":["trace[457129212] 'process raft request'  (duration: 132.013755ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:03:04.540399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9566}
{"level":"info","ts":"2026-08-24T21:03:04.617276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9566,"took":"74.587239ms","hash":897497516,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":28819456,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-24T21:03:04.617353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":897497516,"revision":9566,"compact-revision":6672}
{"level":"info","ts":"2026-08-24T21:07:48.91965Z","caller":"traceutil/trace.go:171","msg":"trace[1008098476] transaction","detail":"{read_only:false; response_revision:14701; number_of_response:1; }","duration":"165.337517ms","start":"2026-08-24T21:07:48.75428Z","end":"2026-08-24T21:07:48.919617Z","steps":["trace[1008098476] 'process raft request'  (duration: 165.146783ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:08:01.122564Z","caller":"traceutil/trace.go:171","msg":"trace[475710819] transaction","detail":"{read_only:false; response_revision:14797; number_of_response:1; }","duration":"134.300949ms","start":"2026-08-24T21:08:00.988219Z","end":"2026-08-24T21:08:01.12252Z","steps":["trace[475710819] 'process raft request'  (duration: 134.043602ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:08:04.546236Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12398}
{"level":"info","ts":"2026-08-24T21:08:04.642862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12398,"took":"94.199108ms","hash":321270118,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":25632768,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-24T21:08:04.642917Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":321270118,"revision":12398,"compact-revision":9566}
{"level":"warn","ts":"2026-08-24T21:08:07.674789Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521228423438340881,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-24T21:08:07.798712Z","caller":"traceutil/trace.go:171","msg":"trace[1705249349] linearizableReadLoop","detail":"{readStateIndex:15529; appliedIndex:15528; }","duration":"624.037561ms","start":"2026-08-24T21:08:07.174638Z","end":"2026-08-24T21:08:07.798676Z","steps":["trace[1705249349] 'read index received'  (duration: 623.673012ms)","trace[1705249349] 'applied index is now lower than readState.Index'  (duration: 363.139µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:08:07.798803Z","caller":"traceutil/trace.go:171","msg":"trace[540270099] transaction","detail":"{read_only:false; response_revision:14839; number_of_response:1; }","duration":"642.724508ms","start":"2026-08-24T21:08:07.156045Z","end":"2026-08-24T21:08:07.798769Z","steps":["trace[540270099] 'process raft request'  (duration: 642.38804ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:07.799043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:08:07.156016Z","time spent":"642.931823ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:14823 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-24T21:08:07.799102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.43736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-08-24T21:08:07.799181Z","caller":"traceutil/trace.go:171","msg":"trace[1759464833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14839; }","duration":"624.575254ms","start":"2026-08-24T21:08:07.174585Z","end":"2026-08-24T21:08:07.79916Z","steps":["trace[1759464833] 'agreement among raft nodes before linearized reading'  (duration: 624.342528ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:07.799241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:08:07.174559Z","time spent":"624.671256ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-24T21:08:07.799346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.723518ms","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-24T21:08:07.799465Z","caller":"traceutil/trace.go:171","msg":"trace[1307482522] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:14839; }","duration":"290.889062ms","start":"2026-08-24T21:08:07.508546Z","end":"2026-08-24T21:08:07.799435Z","steps":["trace[1307482522] 'agreement among raft nodes before linearized reading'  (duration: 290.585405ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:07.799888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.064221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:82 size:714950"}
{"level":"info","ts":"2026-08-24T21:08:07.799921Z","caller":"traceutil/trace.go:171","msg":"trace[628778016] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:82; response_revision:14839; }","duration":"441.131093ms","start":"2026-08-24T21:08:07.358782Z","end":"2026-08-24T21:08:07.799913Z","steps":["trace[628778016] 'agreement among raft nodes before linearized reading'  (duration: 440.302342ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:07.799942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:08:07.358761Z","time spent":"441.174643ms","remote":"127.0.0.1:50172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":82,"response size":714972,"request content":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" "}
{"level":"warn","ts":"2026-08-24T21:08:08.143437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.50565ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438340885 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:14824 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-24T21:08:08.143576Z","caller":"traceutil/trace.go:171","msg":"trace[530603054] transaction","detail":"{read_only:false; response_revision:14840; number_of_response:1; }","duration":"339.77599ms","start":"2026-08-24T21:08:07.803777Z","end":"2026-08-24T21:08:08.143553Z","steps":["trace[530603054] 'process raft request'  (duration: 199.042614ms)","trace[530603054] 'compare'  (duration: 140.356447ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:08:08.143624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:08:07.803752Z","time spent":"339.851711ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:14824 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-24T21:08:08.146261Z","caller":"traceutil/trace.go:171","msg":"trace[463140609] linearizableReadLoop","detail":"{readStateIndex:15531; appliedIndex:15529; }","duration":"261.492323ms","start":"2026-08-24T21:08:07.88474Z","end":"2026-08-24T21:08:08.146233Z","steps":["trace[463140609] 'read index received'  (duration: 118.000049ms)","trace[463140609] 'applied index is now lower than readState.Index'  (duration: 143.490834ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:08:08.146416Z","caller":"traceutil/trace.go:171","msg":"trace[1793389120] transaction","detail":"{read_only:false; response_revision:14841; number_of_response:1; }","duration":"342.597879ms","start":"2026-08-24T21:08:07.803805Z","end":"2026-08-24T21:08:08.146403Z","steps":["trace[1793389120] 'process raft request'  (duration: 342.270331ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:08.146541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:08:07.803785Z","time spent":"342.663841ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:14723 > 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":"warn","ts":"2026-08-24T21:08:08.146688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.126255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-08-24T21:08:08.146771Z","caller":"traceutil/trace.go:171","msg":"trace[1447777096] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:14841; }","duration":"143.253538ms","start":"2026-08-24T21:08:08.003498Z","end":"2026-08-24T21:08:08.146752Z","steps":["trace[1447777096] 'agreement among raft nodes before linearized reading'  (duration: 142.937681ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:08.146945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.214471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:138"}
{"level":"info","ts":"2026-08-24T21:08:08.146965Z","caller":"traceutil/trace.go:171","msg":"trace[1881488009] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:14841; }","duration":"262.272602ms","start":"2026-08-24T21:08:07.884686Z","end":"2026-08-24T21:08:08.146959Z","steps":["trace[1881488009] 'agreement among raft nodes before linearized reading'  (duration: 262.192071ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:08.147256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.205594ms","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-24T21:08:08.147277Z","caller":"traceutil/trace.go:171","msg":"trace[1220304831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14841; }","duration":"140.271456ms","start":"2026-08-24T21:08:08.006999Z","end":"2026-08-24T21:08:08.14727Z","steps":["trace[1220304831] 'agreement among raft nodes before linearized reading'  (duration: 140.209644ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:08:08.147337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.306052ms","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-24T21:08:08.147385Z","caller":"traceutil/trace.go:171","msg":"trace[741067363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14841; }","duration":"137.385794ms","start":"2026-08-24T21:08:08.009986Z","end":"2026-08-24T21:08:08.147372Z","steps":["trace[741067363] 'agreement among raft nodes before linearized reading'  (duration: 137.20927ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:10:02.260016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.830073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-24T21:10:02.26069Z","caller":"traceutil/trace.go:171","msg":"trace[1296613819] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:16264; }","duration":"202.617632ms","start":"2026-08-24T21:10:02.058044Z","end":"2026-08-24T21:10:02.260661Z","steps":["trace[1296613819] 'count revisions from in-memory index tree'  (duration: 201.616037ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:10:02.262905Z","caller":"traceutil/trace.go:171","msg":"trace[1740038391] transaction","detail":"{read_only:false; response_revision:16265; number_of_response:1; }","duration":"153.342305ms","start":"2026-08-24T21:10:02.109532Z","end":"2026-08-24T21:10:02.262874Z","steps":["trace[1740038391] 'process raft request'  (duration: 153.173151ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:10:17.678896Z","caller":"traceutil/trace.go:171","msg":"trace[1501858506] transaction","detail":"{read_only:false; response_revision:16365; number_of_response:1; }","duration":"125.871462ms","start":"2026-08-24T21:10:17.553001Z","end":"2026-08-24T21:10:17.678873Z","steps":["trace[1501858506] 'process raft request'  (duration: 125.622406ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:10:17.679134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.451965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-t2xcm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-08-24T21:10:17.678873Z","caller":"traceutil/trace.go:171","msg":"trace[258891520] linearizableReadLoop","detail":"{readStateIndex:17123; appliedIndex:17122; }","duration":"117.186779ms","start":"2026-08-24T21:10:17.561658Z","end":"2026-08-24T21:10:17.678845Z","steps":["trace[258891520] 'read index received'  (duration: 116.898142ms)","trace[258891520] 'applied index is now lower than readState.Index'  (duration: 287.847µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:10:17.679184Z","caller":"traceutil/trace.go:171","msg":"trace[437808070] range","detail":"{range_begin:/registry/pods/openstack/keepalived-t2xcm; range_end:; response_count:1; response_revision:16365; }","duration":"117.558658ms","start":"2026-08-24T21:10:17.561615Z","end":"2026-08-24T21:10:17.679174Z","steps":["trace[437808070] 'agreement among raft nodes before linearized reading'  (duration: 117.322392ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:12:58.137001Z","caller":"traceutil/trace.go:171","msg":"trace[326355104] transaction","detail":"{read_only:false; response_revision:17876; number_of_response:1; }","duration":"106.765833ms","start":"2026-08-24T21:12:58.030201Z","end":"2026-08-24T21:12:58.136966Z","steps":["trace[326355104] 'process raft request'  (duration: 106.523037ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:13:04.552479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14821}
{"level":"info","ts":"2026-08-24T21:13:04.650144Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14821,"took":"94.050438ms","hash":441085359,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":31371264,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-24T21:13:04.650215Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":441085359,"revision":14821,"compact-revision":12398}
{"level":"info","ts":"2026-08-24T21:15:29.653554Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"11f26225a5bb9fe3","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-24T21:15:29.65953Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-24T21:15:29.659904Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-24T21:15:34.905456Z","caller":"traceutil/trace.go:171","msg":"trace[1440315295] transaction","detail":"{read_only:false; response_revision:19195; number_of_response:1; }","duration":"102.051792ms","start":"2026-08-24T21:15:34.80338Z","end":"2026-08-24T21:15:34.905432Z","steps":["trace[1440315295] 'process raft request'  (duration: 101.606641ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:15:35.014087Z","caller":"traceutil/trace.go:171","msg":"trace[1959836092] transaction","detail":"{read_only:false; response_revision:19196; number_of_response:1; }","duration":"103.817975ms","start":"2026-08-24T21:15:34.910229Z","end":"2026-08-24T21:15:35.014047Z","steps":["trace[1959836092] 'process raft request'  (duration: 63.842186ms)","trace[1959836092] 'compare'  (duration: 39.813575ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:15:35.04456Z","caller":"traceutil/trace.go:171","msg":"trace[1557553075] transaction","detail":"{read_only:false; response_revision:19199; number_of_response:1; }","duration":"130.972591ms","start":"2026-08-24T21:15:34.913565Z","end":"2026-08-24T21:15:35.044538Z","steps":["trace[1557553075] 'process raft request'  (duration: 130.90995ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:15:35.045032Z","caller":"traceutil/trace.go:171","msg":"trace[1163640118] transaction","detail":"{read_only:false; response_revision:19197; number_of_response:1; }","duration":"134.712653ms","start":"2026-08-24T21:15:34.910309Z","end":"2026-08-24T21:15:35.045022Z","steps":["trace[1163640118] 'process raft request'  (duration: 133.976825ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:15:35.045179Z","caller":"traceutil/trace.go:171","msg":"trace[183802493] transaction","detail":"{read_only:false; response_revision:19198; number_of_response:1; }","duration":"133.924352ms","start":"2026-08-24T21:15:34.911246Z","end":"2026-08-24T21:15:35.045171Z","steps":["trace[183802493] 'process raft request'  (duration: 133.177864ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:15:35.880616Z","caller":"traceutil/trace.go:171","msg":"trace[730460987] linearizableReadLoop","detail":"{readStateIndex:20099; appliedIndex:20098; }","duration":"139.197403ms","start":"2026-08-24T21:15:35.74139Z","end":"2026-08-24T21:15:35.880587Z","steps":["trace[730460987] 'read index received'  (duration: 138.942976ms)","trace[730460987] 'applied index is now lower than readState.Index'  (duration: 253.137µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:15:35.880681Z","caller":"traceutil/trace.go:171","msg":"trace[1638648831] transaction","detail":"{read_only:false; response_revision:19201; number_of_response:1; }","duration":"285.915219ms","start":"2026-08-24T21:15:35.594729Z","end":"2026-08-24T21:15:35.880644Z","steps":["trace[1638648831] 'process raft request'  (duration: 285.655773ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:15:35.880904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.47962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:15:35.880999Z","caller":"traceutil/trace.go:171","msg":"trace[1748841040] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:19201; }","duration":"139.646414ms","start":"2026-08-24T21:15:35.741326Z","end":"2026-08-24T21:15:35.880972Z","steps":["trace[1748841040] 'agreement among raft nodes before linearized reading'  (duration: 139.410548ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:18:04.559415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17942}
{"level":"info","ts":"2026-08-24T21:18:04.673995Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17942,"took":"110.845549ms","hash":154950989,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":31842304,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-24T21:18:04.680301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":154950989,"revision":17942,"compact-revision":14821}
{"level":"info","ts":"2026-08-24T21:23:04.568061Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20787}
{"level":"info","ts":"2026-08-24T21:23:04.687652Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20787,"took":"115.937824ms","hash":405258803,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":32256000,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-24T21:23:04.687756Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":405258803,"revision":20787,"compact-revision":17942}
{"level":"warn","ts":"2026-08-24T21:23:09.302038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.196652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:23:09.302137Z","caller":"traceutil/trace.go:171","msg":"trace[1634732050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23506; }","duration":"169.346276ms","start":"2026-08-24T21:23:09.132769Z","end":"2026-08-24T21:23:09.302116Z","steps":["trace[1634732050] 'range keys from in-memory index tree'  (duration: 169.118389ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:23:30.393697Z","caller":"traceutil/trace.go:171","msg":"trace[768537999] linearizableReadLoop","detail":"{readStateIndex:24755; appliedIndex:24754; }","duration":"163.929542ms","start":"2026-08-24T21:23:30.229739Z","end":"2026-08-24T21:23:30.393668Z","steps":["trace[768537999] 'read index received'  (duration: 163.580303ms)","trace[768537999] 'applied index is now lower than readState.Index'  (duration: 347.709µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:23:30.39374Z","caller":"traceutil/trace.go:171","msg":"trace[557201349] transaction","detail":"{read_only:false; response_revision:23644; number_of_response:1; }","duration":"168.030574ms","start":"2026-08-24T21:23:30.225678Z","end":"2026-08-24T21:23:30.393708Z","steps":["trace[557201349] 'process raft request'  (duration: 167.792718ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:23:30.393905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.144357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-24T21:23:30.393974Z","caller":"traceutil/trace.go:171","msg":"trace[801792398] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:23644; }","duration":"164.290311ms","start":"2026-08-24T21:23:30.229668Z","end":"2026-08-24T21:23:30.393958Z","steps":["trace[801792398] 'agreement among raft nodes before linearized reading'  (duration: 164.129867ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:23:30.667667Z","caller":"traceutil/trace.go:171","msg":"trace[1666971200] linearizableReadLoop","detail":"{readStateIndex:24756; appliedIndex:24755; }","duration":"255.186931ms","start":"2026-08-24T21:23:30.412457Z","end":"2026-08-24T21:23:30.667644Z","steps":["trace[1666971200] 'read index received'  (duration: 255.063328ms)","trace[1666971200] 'applied index is now lower than readState.Index'  (duration: 122.433µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:23:30.667706Z","caller":"traceutil/trace.go:171","msg":"trace[970011072] transaction","detail":"{read_only:false; number_of_response:0; response_revision:23644; }","duration":"267.040872ms","start":"2026-08-24T21:23:30.400636Z","end":"2026-08-24T21:23:30.667677Z","steps":["trace[970011072] 'process raft request'  (duration: 266.900619ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:23:30.667905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.433567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-08-24T21:23:30.667953Z","caller":"traceutil/trace.go:171","msg":"trace[360799747] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23644; }","duration":"255.53673ms","start":"2026-08-24T21:23:30.412402Z","end":"2026-08-24T21:23:30.667939Z","steps":["trace[360799747] 'agreement among raft nodes before linearized reading'  (duration: 255.342225ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:23:30.822037Z","caller":"traceutil/trace.go:171","msg":"trace[714282071] transaction","detail":"{read_only:false; response_revision:23646; number_of_response:1; }","duration":"108.872681ms","start":"2026-08-24T21:23:30.713129Z","end":"2026-08-24T21:23:30.822001Z","steps":["trace[714282071] 'process raft request'  (duration: 94.823777ms)","trace[714282071] 'compare'  (duration: 13.895851ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:23:30.879073Z","caller":"traceutil/trace.go:171","msg":"trace[455836787] transaction","detail":"{read_only:false; response_revision:23647; number_of_response:1; }","duration":"159.445731ms","start":"2026-08-24T21:23:30.719591Z","end":"2026-08-24T21:23:30.879037Z","steps":["trace[455836787] 'process raft request'  (duration: 159.240396ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:27:07.95835Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b10.wal"}
{"level":"info","ts":"2026-08-24T21:27:14.856466Z","caller":"traceutil/trace.go:171","msg":"trace[1767514187] transaction","detail":"{read_only:false; response_revision:26364; number_of_response:1; }","duration":"127.047777ms","start":"2026-08-24T21:27:14.729391Z","end":"2026-08-24T21:27:14.856439Z","steps":["trace[1767514187] 'process raft request'  (duration: 126.886493ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:27:15.117622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.373587ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438376942 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26303 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:27:15.117804Z","caller":"traceutil/trace.go:171","msg":"trace[1830102023] transaction","detail":"{read_only:false; response_revision:26365; number_of_response:1; }","duration":"250.895685ms","start":"2026-08-24T21:27:14.866834Z","end":"2026-08-24T21:27:15.11773Z","steps":["trace[1830102023] 'process raft request'  (duration: 96.323863ms)","trace[1830102023] 'compare'  (duration: 154.092641ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:27:15.117928Z","caller":"traceutil/trace.go:171","msg":"trace[2036309949] linearizableReadLoop","detail":"{readStateIndex:27592; appliedIndex:27591; }","duration":"218.725987ms","start":"2026-08-24T21:27:14.899188Z","end":"2026-08-24T21:27:15.117914Z","steps":["trace[2036309949] 'read index received'  (duration: 64.00057ms)","trace[2036309949] 'applied index is now lower than readState.Index'  (duration: 154.724677ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:27:15.118115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.904291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-24T21:27:15.118152Z","caller":"traceutil/trace.go:171","msg":"trace[1640817363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26366; }","duration":"219.001363ms","start":"2026-08-24T21:27:14.899137Z","end":"2026-08-24T21:27:15.118138Z","steps":["trace[1640817363] 'agreement among raft nodes before linearized reading'  (duration: 218.85636ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:27:15.151962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.969849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-08-24T21:27:15.151995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.941403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7350"}
{"level":"info","ts":"2026-08-24T21:27:15.152062Z","caller":"traceutil/trace.go:171","msg":"trace[1677655470] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26367; }","duration":"108.282367ms","start":"2026-08-24T21:27:15.043745Z","end":"2026-08-24T21:27:15.152027Z","steps":["trace[1677655470] 'agreement among raft nodes before linearized reading'  (duration: 107.913547ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:27:15.152187Z","caller":"traceutil/trace.go:171","msg":"trace[1524995981] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:26367; }","duration":"142.163369ms","start":"2026-08-24T21:27:15.009924Z","end":"2026-08-24T21:27:15.152087Z","steps":["trace[1524995981] 'agreement among raft nodes before linearized reading'  (duration: 141.633425ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:27:15.152382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.243126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-24T21:27:15.152441Z","caller":"traceutil/trace.go:171","msg":"trace[275337829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26367; }","duration":"121.333478ms","start":"2026-08-24T21:27:15.031086Z","end":"2026-08-24T21:27:15.15242Z","steps":["trace[275337829] 'agreement among raft nodes before linearized reading'  (duration: 121.110172ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:28:04.578279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23479}
{"level":"info","ts":"2026-08-24T21:28:04.689427Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23479,"took":"106.928779ms","hash":3880263534,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":44978176,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-08-24T21:28:04.689533Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3880263534,"revision":23479,"compact-revision":20787}
{"level":"info","ts":"2026-08-24T21:30:34.289221Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"11f26225a5bb9fe3","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-24T21:30:34.295528Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-24T21:30:34.295809Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-08-24T21:30:39.516731Z","caller":"traceutil/trace.go:171","msg":"trace[252153737] transaction","detail":"{read_only:false; response_revision:28774; number_of_response:1; }","duration":"106.701623ms","start":"2026-08-24T21:30:39.410002Z","end":"2026-08-24T21:30:39.516704Z","steps":["trace[252153737] 'process raft request'  (duration: 106.539539ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:49.767391Z","caller":"traceutil/trace.go:171","msg":"trace[896699660] transaction","detail":"{read_only:false; response_revision:28868; number_of_response:1; }","duration":"106.902588ms","start":"2026-08-24T21:30:49.660456Z","end":"2026-08-24T21:30:49.767358Z","steps":["trace[896699660] 'process raft request'  (duration: 106.685273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.037593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.380218ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383054 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:28849 > 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:18"}
{"level":"info","ts":"2026-08-24T21:30:50.038147Z","caller":"traceutil/trace.go:171","msg":"trace[587827045] transaction","detail":"{read_only:false; response_revision:28869; number_of_response:1; }","duration":"234.39391ms","start":"2026-08-24T21:30:49.803726Z","end":"2026-08-24T21:30:50.038119Z","steps":["trace[587827045] 'process raft request'  (duration: 95.409559ms)","trace[587827045] 'compare'  (duration: 138.260604ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:30:50.038677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.237687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-08-24T21:30:50.03883Z","caller":"traceutil/trace.go:171","msg":"trace[1265018815] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:28869; }","duration":"114.446792ms","start":"2026-08-24T21:30:49.924345Z","end":"2026-08-24T21:30:50.038792Z","steps":["trace[1265018815] 'agreement among raft nodes before linearized reading'  (duration: 113.996272ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.037986Z","caller":"traceutil/trace.go:171","msg":"trace[1165902439] linearizableReadLoop","detail":"{readStateIndex:30192; appliedIndex:30191; }","duration":"113.554081ms","start":"2026-08-24T21:30:49.924404Z","end":"2026-08-24T21:30:50.037958Z","steps":["trace[1165902439] 'read index received'  (duration: 83.112µs)","trace[1165902439] 'applied index is now lower than readState.Index'  (duration: 113.469799ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:50.253556Z","caller":"traceutil/trace.go:171","msg":"trace[867066594] transaction","detail":"{read_only:false; response_revision:28871; number_of_response:1; }","duration":"193.849ms","start":"2026-08-24T21:30:50.059661Z","end":"2026-08-24T21:30:50.25351Z","steps":["trace[867066594] 'process raft request'  (duration: 127.852279ms)","trace[867066594] 'compare'  (duration: 65.555751ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:50.546898Z","caller":"traceutil/trace.go:171","msg":"trace[1732833885] linearizableReadLoop","detail":"{readStateIndex:30195; appliedIndex:30194; }","duration":"282.838591ms","start":"2026-08-24T21:30:50.264017Z","end":"2026-08-24T21:30:50.546856Z","steps":["trace[1732833885] 'read index received'  (duration: 253.511836ms)","trace[1732833885] 'applied index is now lower than readState.Index'  (duration: 29.323825ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:50.547155Z","caller":"traceutil/trace.go:171","msg":"trace[100657355] transaction","detail":"{read_only:false; response_revision:28872; number_of_response:1; }","duration":"284.579815ms","start":"2026-08-24T21:30:50.262528Z","end":"2026-08-24T21:30:50.547108Z","steps":["trace[100657355] 'process raft request'  (duration: 254.990732ms)","trace[100657355] 'compare'  (duration: 29.161321ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:30:50.547318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.271562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-08-24T21:30:50.547396Z","caller":"traceutil/trace.go:171","msg":"trace[58534427] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:28872; }","duration":"283.366624ms","start":"2026-08-24T21:30:50.264006Z","end":"2026-08-24T21:30:50.547372Z","steps":["trace[58534427] 'agreement among raft nodes before linearized reading'  (duration: 283.075567ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.549454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.624639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-24T21:30:50.549536Z","caller":"traceutil/trace.go:171","msg":"trace[2131866131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:28874; }","duration":"176.771464ms","start":"2026-08-24T21:30:50.372747Z","end":"2026-08-24T21:30:50.549518Z","steps":["trace[2131866131] 'agreement among raft nodes before linearized reading'  (duration: 176.570039ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.549759Z","caller":"traceutil/trace.go:171","msg":"trace[1575927219] transaction","detail":"{read_only:false; response_revision:28873; number_of_response:1; }","duration":"124.98773ms","start":"2026-08-24T21:30:50.424758Z","end":"2026-08-24T21:30:50.549746Z","steps":["trace[1575927219] 'process raft request'  (duration: 124.443746ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.549929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.116989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-24T21:30:50.549954Z","caller":"traceutil/trace.go:171","msg":"trace[416265460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:28874; }","duration":"156.159101ms","start":"2026-08-24T21:30:50.393787Z","end":"2026-08-24T21:30:50.549947Z","steps":["trace[416265460] 'agreement among raft nodes before linearized reading'  (duration: 156.096839ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.550058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.832398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-08-24T21:30:50.55008Z","caller":"traceutil/trace.go:171","msg":"trace[1911023663] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:28874; }","duration":"156.893908ms","start":"2026-08-24T21:30:50.393181Z","end":"2026-08-24T21:30:50.550074Z","steps":["trace[1911023663] 'agreement among raft nodes before linearized reading'  (duration: 156.839347ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.550184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.511778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-24T21:30:50.550205Z","caller":"traceutil/trace.go:171","msg":"trace[100978750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:28874; }","duration":"160.580909ms","start":"2026-08-24T21:30:50.389619Z","end":"2026-08-24T21:30:50.5502Z","steps":["trace[100978750] 'agreement among raft nodes before linearized reading'  (duration: 160.525538ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.550305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.137815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-24T21:30:50.550325Z","caller":"traceutil/trace.go:171","msg":"trace[771217503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:28874; }","duration":"173.206137ms","start":"2026-08-24T21:30:50.377114Z","end":"2026-08-24T21:30:50.55032Z","steps":["trace[771217503] 'agreement among raft nodes before linearized reading'  (duration: 173.152856ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.854411Z","caller":"traceutil/trace.go:171","msg":"trace[1300669346] linearizableReadLoop","detail":"{readStateIndex:30203; appliedIndex:30198; }","duration":"243.248055ms","start":"2026-08-24T21:30:50.611139Z","end":"2026-08-24T21:30:50.854387Z","steps":["trace[1300669346] 'read index received'  (duration: 243.007239ms)","trace[1300669346] 'applied index is now lower than readState.Index'  (duration: 239.646µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:50.854478Z","caller":"traceutil/trace.go:171","msg":"trace[1165689411] transaction","detail":"{read_only:false; response_revision:28877; number_of_response:1; }","duration":"296.811853ms","start":"2026-08-24T21:30:50.557612Z","end":"2026-08-24T21:30:50.854424Z","steps":["trace[1165689411] 'process raft request'  (duration: 296.616888ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:50.854633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.470401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-08-24T21:30:50.854676Z","caller":"traceutil/trace.go:171","msg":"trace[1819095718] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:28880; }","duration":"243.586254ms","start":"2026-08-24T21:30:50.611078Z","end":"2026-08-24T21:30:50.854664Z","steps":["trace[1819095718] 'agreement among raft nodes before linearized reading'  (duration: 243.407689ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.854692Z","caller":"traceutil/trace.go:171","msg":"trace[647190865] transaction","detail":"{read_only:false; response_revision:28880; number_of_response:1; }","duration":"295.358656ms","start":"2026-08-24T21:30:50.559289Z","end":"2026-08-24T21:30:50.854648Z","steps":["trace[647190865] 'process raft request'  (duration: 295.039369ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.854806Z","caller":"traceutil/trace.go:171","msg":"trace[501178957] transaction","detail":"{read_only:false; response_revision:28876; number_of_response:1; }","duration":"297.193592ms","start":"2026-08-24T21:30:50.557594Z","end":"2026-08-24T21:30:50.854788Z","steps":["trace[501178957] 'process raft request'  (duration: 296.464034ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.85465Z","caller":"traceutil/trace.go:171","msg":"trace[1193764060] transaction","detail":"{read_only:false; response_revision:28879; number_of_response:1; }","duration":"296.851033ms","start":"2026-08-24T21:30:50.557755Z","end":"2026-08-24T21:30:50.854606Z","steps":["trace[1193764060] 'process raft request'  (duration: 296.535316ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.85529Z","caller":"traceutil/trace.go:171","msg":"trace[1135425876] transaction","detail":"{read_only:false; response_revision:28878; number_of_response:1; }","duration":"297.612563ms","start":"2026-08-24T21:30:50.557656Z","end":"2026-08-24T21:30:50.855269Z","steps":["trace[1135425876] 'process raft request'  (duration: 296.609288ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:50.889885Z","caller":"traceutil/trace.go:171","msg":"trace[6058213] transaction","detail":"{read_only:false; response_revision:28881; number_of_response:1; }","duration":"277.910221ms","start":"2026-08-24T21:30:50.611947Z","end":"2026-08-24T21:30:50.889858Z","steps":["trace[6058213] 'process raft request'  (duration: 277.746557ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:51.059611Z","caller":"traceutil/trace.go:171","msg":"trace[1538479443] transaction","detail":"{read_only:false; response_revision:28882; number_of_response:1; }","duration":"199.593191ms","start":"2026-08-24T21:30:50.859985Z","end":"2026-08-24T21:30:51.059579Z","steps":["trace[1538479443] 'process raft request'  (duration: 188.970041ms)","trace[1538479443] 'compare'  (duration: 10.232909ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:30:51.348524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.976433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:30:51.348654Z","caller":"traceutil/trace.go:171","msg":"trace[1695457628] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:28882; }","duration":"151.170568ms","start":"2026-08-24T21:30:51.197453Z","end":"2026-08-24T21:30:51.348624Z","steps":["trace[1695457628] 'range keys from in-memory index tree'  (duration: 150.883422ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:51.348663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.063652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-08-24T21:30:51.348733Z","caller":"traceutil/trace.go:171","msg":"trace[1988851870] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:28882; }","duration":"157.178135ms","start":"2026-08-24T21:30:51.191538Z","end":"2026-08-24T21:30:51.348717Z","steps":["trace[1988851870] 'range keys from in-memory index tree'  (duration: 156.911028ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:51.348762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.561544ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383081 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:28836 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:30:51.348909Z","caller":"traceutil/trace.go:171","msg":"trace[728001937] transaction","detail":"{read_only:false; response_revision:28883; number_of_response:1; }","duration":"150.460601ms","start":"2026-08-24T21:30:51.198425Z","end":"2026-08-24T21:30:51.348885Z","steps":["trace[728001937] 'compare'  (duration: 143.298038ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:51.359827Z","caller":"traceutil/trace.go:171","msg":"trace[1194861411] transaction","detail":"{read_only:false; response_revision:28884; number_of_response:1; }","duration":"144.442035ms","start":"2026-08-24T21:30:51.215356Z","end":"2026-08-24T21:30:51.359798Z","steps":["trace[1194861411] 'process raft request'  (duration: 144.24877ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:51.372579Z","caller":"traceutil/trace.go:171","msg":"trace[698217053] transaction","detail":"{read_only:false; response_revision:28885; number_of_response:1; }","duration":"100.194365ms","start":"2026-08-24T21:30:51.272344Z","end":"2026-08-24T21:30:51.372539Z","steps":["trace[698217053] 'process raft request'  (duration: 99.701153ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:52.443758Z","caller":"traceutil/trace.go:171","msg":"trace[1658227663] transaction","detail":"{read_only:false; response_revision:28887; number_of_response:1; }","duration":"391.817981ms","start":"2026-08-24T21:30:52.0519Z","end":"2026-08-24T21:30:52.443718Z","steps":["trace[1658227663] 'process raft request'  (duration: 391.624446ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:52.443915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.051862Z","time spent":"391.974544ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:28870 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-24T21:30:53.109263Z","caller":"traceutil/trace.go:171","msg":"trace[1191869225] transaction","detail":"{read_only:false; response_revision:28892; number_of_response:1; }","duration":"243.178934ms","start":"2026-08-24T21:30:52.866058Z","end":"2026-08-24T21:30:53.109237Z","steps":["trace[1191869225] 'process raft request'  (duration: 243ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.273516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.952879ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383107 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:28878 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:30:53.273874Z","caller":"traceutil/trace.go:171","msg":"trace[310192544] linearizableReadLoop","detail":"{readStateIndex:30219; appliedIndex:30214; }","duration":"404.344877ms","start":"2026-08-24T21:30:52.86951Z","end":"2026-08-24T21:30:53.273854Z","steps":["trace[310192544] 'read index received'  (duration: 239.554755ms)","trace[310192544] 'applied index is now lower than readState.Index'  (duration: 164.788841ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:53.273878Z","caller":"traceutil/trace.go:171","msg":"trace[706412290] transaction","detail":"{read_only:false; response_revision:28893; number_of_response:1; }","duration":"407.167895ms","start":"2026-08-24T21:30:52.866675Z","end":"2026-08-24T21:30:53.273843Z","steps":["trace[706412290] 'process raft request'  (duration: 272.794716ms)","trace[706412290] 'compare'  (duration: 133.762765ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:53.273983Z","caller":"traceutil/trace.go:171","msg":"trace[282897015] transaction","detail":"{read_only:false; response_revision:28894; number_of_response:1; }","duration":"406.483058ms","start":"2026-08-24T21:30:52.867489Z","end":"2026-08-24T21:30:53.273972Z","steps":["trace[282897015] 'process raft request'  (duration: 406.11976ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.274048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.866664Z","time spent":"407.290208ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:28878 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-24T21:30:53.274115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.867473Z","time spent":"406.601102ms","remote":"127.0.0.1:50326","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:28879 > 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-24T21:30:53.27427Z","caller":"traceutil/trace.go:171","msg":"trace[685512199] transaction","detail":"{read_only:false; response_revision:28895; number_of_response:1; }","duration":"406.682153ms","start":"2026-08-24T21:30:52.867575Z","end":"2026-08-24T21:30:53.274258Z","steps":["trace[685512199] 'process raft request'  (duration: 406.14063ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.274328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.86755Z","time spent":"406.749335ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:28876 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-24T21:30:53.274574Z","caller":"traceutil/trace.go:171","msg":"trace[2050936021] transaction","detail":"{read_only:false; response_revision:28896; number_of_response:1; }","duration":"406.356326ms","start":"2026-08-24T21:30:52.868207Z","end":"2026-08-24T21:30:53.274564Z","steps":["trace[2050936021] 'process raft request'  (duration: 405.556786ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.27463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.868197Z","time spent":"406.402706ms","remote":"127.0.0.1:50326","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:28877 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-24T21:30:53.274766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.259028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:30:53.274753Z","caller":"traceutil/trace.go:171","msg":"trace[2103603366] transaction","detail":"{read_only:false; response_revision:28897; number_of_response:1; }","duration":"378.717861ms","start":"2026-08-24T21:30:52.895984Z","end":"2026-08-24T21:30:53.274702Z","steps":["trace[2103603366] 'process raft request'  (duration: 377.821579ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:53.275004Z","caller":"traceutil/trace.go:171","msg":"trace[539706360] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:28897; }","duration":"405.542725ms","start":"2026-08-24T21:30:52.869444Z","end":"2026-08-24T21:30:53.274986Z","steps":["trace[539706360] 'agreement among raft nodes before linearized reading'  (duration: 405.276848ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.275045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.869416Z","time spent":"405.619257ms","remote":"127.0.0.1:48908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "}
{"level":"warn","ts":"2026-08-24T21:30:53.275114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.23104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:30:53.275124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.369278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:30:53.275209Z","caller":"traceutil/trace.go:171","msg":"trace[52317870] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:28897; }","duration":"301.388944ms","start":"2026-08-24T21:30:52.973795Z","end":"2026-08-24T21:30:53.275184Z","steps":["trace[52317870] 'agreement among raft nodes before linearized reading'  (duration: 301.205179ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:53.275219Z","caller":"traceutil/trace.go:171","msg":"trace[387807566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:28897; }","duration":"143.523082ms","start":"2026-08-24T21:30:53.131678Z","end":"2026-08-24T21:30:53.275201Z","steps":["trace[387807566] 'agreement among raft nodes before linearized reading'  (duration: 143.374478ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.275238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.895965Z","time spent":"379.08212ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:28881 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-24T21:30:53.275272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:52.973773Z","time spent":"301.487346ms","remote":"127.0.0.1:36634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-08-24T21:30:53.275342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.097967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-08-24T21:30:53.275399Z","caller":"traceutil/trace.go:171","msg":"trace[1449912413] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:28897; }","duration":"210.171659ms","start":"2026-08-24T21:30:53.065197Z","end":"2026-08-24T21:30:53.275369Z","steps":["trace[1449912413] 'agreement among raft nodes before linearized reading'  (duration: 210.038976ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:53.494274Z","caller":"traceutil/trace.go:171","msg":"trace[429620436] transaction","detail":"{read_only:false; response_revision:28898; number_of_response:1; }","duration":"210.786784ms","start":"2026-08-24T21:30:53.283445Z","end":"2026-08-24T21:30:53.494232Z","steps":["trace[429620436] 'process raft request'  (duration: 171.761152ms)","trace[429620436] 'compare'  (duration: 38.846228ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:53.57546Z","caller":"traceutil/trace.go:171","msg":"trace[117653088] linearizableReadLoop","detail":"{readStateIndex:30223; appliedIndex:30221; }","duration":"114.075123ms","start":"2026-08-24T21:30:53.461358Z","end":"2026-08-24T21:30:53.575433Z","steps":["trace[117653088] 'read index received'  (duration: 33.061947ms)","trace[117653088] 'applied index is now lower than readState.Index'  (duration: 81.012066ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:53.575545Z","caller":"traceutil/trace.go:171","msg":"trace[1981786460] transaction","detail":"{read_only:false; response_revision:28899; number_of_response:1; }","duration":"207.277968ms","start":"2026-08-24T21:30:53.368221Z","end":"2026-08-24T21:30:53.575499Z","steps":["trace[1981786460] 'process raft request'  (duration: 207.035372ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:53.575721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.33075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-24T21:30:53.575793Z","caller":"traceutil/trace.go:171","msg":"trace[219154507] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:28899; }","duration":"114.476634ms","start":"2026-08-24T21:30:53.461302Z","end":"2026-08-24T21:30:53.575778Z","steps":["trace[219154507] 'agreement among raft nodes before linearized reading'  (duration: 114.292759ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:53.693733Z","caller":"traceutil/trace.go:171","msg":"trace[2115164123] transaction","detail":"{read_only:false; response_revision:28900; number_of_response:1; }","duration":"112.471184ms","start":"2026-08-24T21:30:53.581241Z","end":"2026-08-24T21:30:53.693712Z","steps":["trace[2115164123] 'process raft request'  (duration: 110.981197ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.235618Z","caller":"traceutil/trace.go:171","msg":"trace[1115248656] linearizableReadLoop","detail":"{readStateIndex:30225; appliedIndex:30224; }","duration":"172.188291ms","start":"2026-08-24T21:30:54.063396Z","end":"2026-08-24T21:30:54.235584Z","steps":["trace[1115248656] 'read index received'  (duration: 171.858983ms)","trace[1115248656] 'applied index is now lower than readState.Index'  (duration: 327.768µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:54.235681Z","caller":"traceutil/trace.go:171","msg":"trace[1784999902] transaction","detail":"{read_only:false; response_revision:28901; number_of_response:1; }","duration":"265.258312ms","start":"2026-08-24T21:30:53.970396Z","end":"2026-08-24T21:30:54.235654Z","steps":["trace[1784999902] 'process raft request'  (duration: 264.932694ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:54.235914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.808078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:30:54.235954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.543489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"}
{"level":"warn","ts":"2026-08-24T21:30:54.236014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.629088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-24T21:30:54.236124Z","caller":"traceutil/trace.go:171","msg":"trace[596337242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:28901; }","duration":"153.767931ms","start":"2026-08-24T21:30:54.082308Z","end":"2026-08-24T21:30:54.236076Z","steps":["trace[596337242] 'agreement among raft nodes before linearized reading'  (duration: 153.495944ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.236028Z","caller":"traceutil/trace.go:171","msg":"trace[1302522210] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:28901; }","duration":"172.653142ms","start":"2026-08-24T21:30:54.063357Z","end":"2026-08-24T21:30:54.23601Z","steps":["trace[1302522210] 'agreement among raft nodes before linearized reading'  (duration: 172.387756ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.236027Z","caller":"traceutil/trace.go:171","msg":"trace[868601915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:28901; }","duration":"102.972092ms","start":"2026-08-24T21:30:54.13303Z","end":"2026-08-24T21:30:54.236002Z","steps":["trace[868601915] 'agreement among raft nodes before linearized reading'  (duration: 102.794378ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.526636Z","caller":"traceutil/trace.go:171","msg":"trace[1326850630] transaction","detail":"{read_only:false; number_of_response:0; response_revision:28902; }","duration":"282.924234ms","start":"2026-08-24T21:30:54.243681Z","end":"2026-08-24T21:30:54.526605Z","steps":["trace[1326850630] 'process raft request'  (duration: 281.430618ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.527749Z","caller":"traceutil/trace.go:171","msg":"trace[268822794] linearizableReadLoop","detail":"{readStateIndex:30229; appliedIndex:30226; }","duration":"275.519854ms","start":"2026-08-24T21:30:54.252168Z","end":"2026-08-24T21:30:54.527687Z","steps":["trace[268822794] 'read index received'  (duration: 273.044873ms)","trace[268822794] 'applied index is now lower than readState.Index'  (duration: 2.46954ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:54.527783Z","caller":"traceutil/trace.go:171","msg":"trace[138036258] transaction","detail":"{read_only:false; response_revision:28903; number_of_response:1; }","duration":"283.749865ms","start":"2026-08-24T21:30:54.243996Z","end":"2026-08-24T21:30:54.527746Z","steps":["trace[138036258] 'process raft request'  (duration: 282.493684ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.527912Z","caller":"traceutil/trace.go:171","msg":"trace[1495361754] transaction","detail":"{read_only:false; response_revision:28904; number_of_response:1; }","duration":"283.191751ms","start":"2026-08-24T21:30:54.244697Z","end":"2026-08-24T21:30:54.527889Z","steps":["trace[1495361754] 'process raft request'  (duration: 282.370281ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:54.528023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.833542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:30:54.528092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.693084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"warn","ts":"2026-08-24T21:30:54.528017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.301187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:30:54.528195Z","caller":"traceutil/trace.go:171","msg":"trace[860021548] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:28905; }","duration":"186.540512ms","start":"2026-08-24T21:30:54.341637Z","end":"2026-08-24T21:30:54.528178Z","steps":["trace[860021548] 'agreement among raft nodes before linearized reading'  (duration: 186.306597ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.528196Z","caller":"traceutil/trace.go:171","msg":"trace[1775831419] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:28905; }","duration":"240.837257ms","start":"2026-08-24T21:30:54.287329Z","end":"2026-08-24T21:30:54.528167Z","steps":["trace[1775831419] 'agreement among raft nodes before linearized reading'  (duration: 240.594721ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:54.528096Z","caller":"traceutil/trace.go:171","msg":"trace[2109845215] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:28905; }","duration":"275.960905ms","start":"2026-08-24T21:30:54.252092Z","end":"2026-08-24T21:30:54.528076Z","steps":["trace[2109845215] 'agreement among raft nodes before linearized reading'  (duration: 275.785631ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:55.491191Z","caller":"traceutil/trace.go:171","msg":"trace[1497902820] transaction","detail":"{read_only:false; response_revision:28917; number_of_response:1; }","duration":"173.38082ms","start":"2026-08-24T21:30:55.317776Z","end":"2026-08-24T21:30:55.491157Z","steps":["trace[1497902820] 'process raft request'  (duration: 135.834224ms)","trace[1497902820] 'compare'  (duration: 37.31317ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:30:55.816365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.535191ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383171 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:28893 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:30:55.816722Z","caller":"traceutil/trace.go:171","msg":"trace[1245981333] transaction","detail":"{read_only:false; response_revision:28921; number_of_response:1; }","duration":"236.689585ms","start":"2026-08-24T21:30:55.580013Z","end":"2026-08-24T21:30:55.816703Z","steps":["trace[1245981333] 'process raft request'  (duration: 236.638804ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:55.816789Z","caller":"traceutil/trace.go:171","msg":"trace[1196229218] transaction","detail":"{read_only:false; response_revision:28919; number_of_response:1; }","duration":"498.670179ms","start":"2026-08-24T21:30:55.318086Z","end":"2026-08-24T21:30:55.816756Z","steps":["trace[1196229218] 'process raft request'  (duration: 498.404582ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:55.816983Z","caller":"traceutil/trace.go:171","msg":"trace[1974928916] transaction","detail":"{read_only:false; response_revision:28920; number_of_response:1; }","duration":"498.570346ms","start":"2026-08-24T21:30:55.318399Z","end":"2026-08-24T21:30:55.81697Z","steps":["trace[1974928916] 'process raft request'  (duration: 498.203737ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:30:55.817105Z","caller":"traceutil/trace.go:171","msg":"trace[1997413825] transaction","detail":"{read_only:false; response_revision:28918; number_of_response:1; }","duration":"499.233952ms","start":"2026-08-24T21:30:55.317849Z","end":"2026-08-24T21:30:55.817083Z","steps":["trace[1997413825] 'process raft request'  (duration: 327.888151ms)","trace[1997413825] 'compare'  (duration: 170.321355ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:30:55.817114Z","caller":"traceutil/trace.go:171","msg":"trace[1061122040] linearizableReadLoop","detail":"{readStateIndex:30245; appliedIndex:30241; }","duration":"479.435999ms","start":"2026-08-24T21:30:55.337624Z","end":"2026-08-24T21:30:55.81706Z","steps":["trace[1061122040] 'read index received'  (duration: 116.085342ms)","trace[1061122040] 'applied index is now lower than readState.Index'  (duration: 363.330166ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:30:55.817271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:55.318393Z","time spent":"498.627247ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:28895 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-24T21:30:55.817338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.697075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"warn","ts":"2026-08-24T21:30:55.817346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:55.317826Z","time spent":"499.327954ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:28893 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-24T21:30:55.817406Z","caller":"traceutil/trace.go:171","msg":"trace[654531575] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:28921; }","duration":"479.804448ms","start":"2026-08-24T21:30:55.337582Z","end":"2026-08-24T21:30:55.817386Z","steps":["trace[654531575] 'agreement among raft nodes before linearized reading'  (duration: 479.604483ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:30:55.817446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:55.33756Z","time spent":"479.879589ms","remote":"127.0.0.1:50228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":1874,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" "}
{"level":"warn","ts":"2026-08-24T21:30:55.817494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.971714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:647"}
{"level":"warn","ts":"2026-08-24T21:30:55.817539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:30:55.31806Z","time spent":"498.828912ms","remote":"127.0.0.1:50326","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:28896 > 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-24T21:30:55.817572Z","caller":"traceutil/trace.go:171","msg":"trace[2057018832] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:28921; }","duration":"119.102017ms","start":"2026-08-24T21:30:55.698448Z","end":"2026-08-24T21:30:55.81755Z","steps":["trace[2057018832] 'agreement among raft nodes before linearized reading'  (duration: 118.83232ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:04.893912Z","caller":"traceutil/trace.go:171","msg":"trace[426914912] transaction","detail":"{read_only:false; response_revision:28996; number_of_response:1; }","duration":"113.90481ms","start":"2026-08-24T21:31:04.779976Z","end":"2026-08-24T21:31:04.893881Z","steps":["trace[426914912] 'process raft request'  (duration: 113.731646ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:04.97761Z","caller":"traceutil/trace.go:171","msg":"trace[1893996107] transaction","detail":"{read_only:false; response_revision:28997; number_of_response:1; }","duration":"153.651229ms","start":"2026-08-24T21:31:04.823932Z","end":"2026-08-24T21:31:04.977583Z","steps":["trace[1893996107] 'process raft request'  (duration: 152.957972ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:09.473514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.073424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-24T21:31:09.473612Z","caller":"traceutil/trace.go:171","msg":"trace[2068151354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29034; }","duration":"248.213558ms","start":"2026-08-24T21:31:09.225377Z","end":"2026-08-24T21:31:09.473591Z","steps":["trace[2068151354] 'range keys from in-memory index tree'  (duration: 247.880799ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:09.473771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.991085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"}
{"level":"info","ts":"2026-08-24T21:31:09.473848Z","caller":"traceutil/trace.go:171","msg":"trace[1455386521] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:29034; }","duration":"149.113158ms","start":"2026-08-24T21:31:09.324711Z","end":"2026-08-24T21:31:09.473824Z","steps":["trace[1455386521] 'range keys from in-memory index tree'  (duration: 148.799891ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:09.475695Z","caller":"traceutil/trace.go:171","msg":"trace[1580088771] transaction","detail":"{read_only:false; response_revision:29035; number_of_response:1; }","duration":"108.21387ms","start":"2026-08-24T21:31:09.367461Z","end":"2026-08-24T21:31:09.475675Z","steps":["trace[1580088771] 'process raft request'  (duration: 108.082006ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.078775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.318277ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383468 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:29017 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:31:10.078971Z","caller":"traceutil/trace.go:171","msg":"trace[796652489] linearizableReadLoop","detail":"{readStateIndex:30367; appliedIndex:30366; }","duration":"521.820052ms","start":"2026-08-24T21:31:09.557077Z","end":"2026-08-24T21:31:10.078897Z","steps":["trace[796652489] 'read index received'  (duration: 203.223528ms)","trace[796652489] 'applied index is now lower than readState.Index'  (duration: 318.594744ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:10.079038Z","caller":"traceutil/trace.go:171","msg":"trace[1329427362] transaction","detail":"{read_only:false; response_revision:29036; number_of_response:1; }","duration":"600.545595ms","start":"2026-08-24T21:31:09.478447Z","end":"2026-08-24T21:31:10.078992Z","steps":["trace[1329427362] 'process raft request'  (duration: 281.884359ms)","trace[1329427362] 'compare'  (duration: 318.160584ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:10.079258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:09.47842Z","time spent":"600.709578ms","remote":"127.0.0.1:50326","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:29017 > 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":"warn","ts":"2026-08-24T21:31:10.079473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.386046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-08-24T21:31:10.079554Z","caller":"traceutil/trace.go:171","msg":"trace[1578593230] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:29036; }","duration":"522.469908ms","start":"2026-08-24T21:31:09.557039Z","end":"2026-08-24T21:31:10.079509Z","steps":["trace[1578593230] 'agreement among raft nodes before linearized reading'  (duration: 522.039058ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.079637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:09.557021Z","time spent":"522.578622ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":555,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"info","ts":"2026-08-24T21:31:10.176186Z","caller":"traceutil/trace.go:171","msg":"trace[1997339052] transaction","detail":"{read_only:false; response_revision:29037; number_of_response:1; }","duration":"301.148879ms","start":"2026-08-24T21:31:09.875016Z","end":"2026-08-24T21:31:10.176165Z","steps":["trace[1997339052] 'process raft request'  (duration: 300.81338ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.176315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:09.874982Z","time spent":"301.266951ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:29021 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:10.176482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.748269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:10.176512Z","caller":"traceutil/trace.go:171","msg":"trace[776488709] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:29037; }","duration":"125.814401ms","start":"2026-08-24T21:31:10.050691Z","end":"2026-08-24T21:31:10.176505Z","steps":["trace[776488709] 'agreement among raft nodes before linearized reading'  (duration: 125.759719ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.176672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.068979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-08-24T21:31:10.176695Z","caller":"traceutil/trace.go:171","msg":"trace[307408384] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:29037; }","duration":"163.131882ms","start":"2026-08-24T21:31:10.013556Z","end":"2026-08-24T21:31:10.176688Z","steps":["trace[307408384] 'agreement among raft nodes before linearized reading'  (duration: 163.04994ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.176796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.606428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:10.176869Z","caller":"traceutil/trace.go:171","msg":"trace[201383505] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:29037; }","duration":"487.721421ms","start":"2026-08-24T21:31:09.689142Z","end":"2026-08-24T21:31:10.176864Z","steps":["trace[201383505] 'agreement among raft nodes before linearized reading'  (duration: 487.634969ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.176889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:09.689122Z","time spent":"487.760622ms","remote":"127.0.0.1:50302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-08-24T21:31:10.176941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.840289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"warn","ts":"2026-08-24T21:31:10.177042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.915512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-24T21:31:10.177041Z","caller":"traceutil/trace.go:171","msg":"trace[1301984027] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:29037; }","duration":"298.001052ms","start":"2026-08-24T21:31:09.879015Z","end":"2026-08-24T21:31:10.177016Z","steps":["trace[1301984027] 'agreement among raft nodes before linearized reading'  (duration: 297.618323ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.177064Z","caller":"traceutil/trace.go:171","msg":"trace[307534945] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29037; }","duration":"611.956053ms","start":"2026-08-24T21:31:09.565102Z","end":"2026-08-24T21:31:10.177058Z","steps":["trace[307534945] 'agreement among raft nodes before linearized reading'  (duration: 611.892001ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.177079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:09.565094Z","time spent":"611.982313ms","remote":"127.0.0.1:50326","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":"warn","ts":"2026-08-24T21:31:10.177299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.310405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:10.177331Z","caller":"traceutil/trace.go:171","msg":"trace[1286995175] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:29037; }","duration":"172.390317ms","start":"2026-08-24T21:31:10.004931Z","end":"2026-08-24T21:31:10.177322Z","steps":["trace[1286995175] 'agreement among raft nodes before linearized reading'  (duration: 172.333166ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.177499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.666708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-24T21:31:10.177535Z","caller":"traceutil/trace.go:171","msg":"trace[1643706485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:29037; }","duration":"280.72741ms","start":"2026-08-24T21:31:09.896799Z","end":"2026-08-24T21:31:10.177527Z","steps":["trace[1643706485] 'agreement among raft nodes before linearized reading'  (duration: 280.646828ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.177873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.923714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-08-24T21:31:10.177906Z","caller":"traceutil/trace.go:171","msg":"trace[1424990105] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:29037; }","duration":"280.999396ms","start":"2026-08-24T21:31:09.896899Z","end":"2026-08-24T21:31:10.177898Z","steps":["trace[1424990105] 'agreement among raft nodes before linearized reading'  (duration: 280.917444ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.177678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.71005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-24T21:31:10.178047Z","caller":"traceutil/trace.go:171","msg":"trace[101857976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:29037; }","duration":"281.12307ms","start":"2026-08-24T21:31:09.896919Z","end":"2026-08-24T21:31:10.178042Z","steps":["trace[101857976] 'agreement among raft nodes before linearized reading'  (duration: 280.71326ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.388946Z","caller":"traceutil/trace.go:171","msg":"trace[1690732472] linearizableReadLoop","detail":"{readStateIndex:30369; appliedIndex:30368; }","duration":"212.963837ms","start":"2026-08-24T21:31:10.175955Z","end":"2026-08-24T21:31:10.388918Z","steps":["trace[1690732472] 'read index received'  (duration: 206.95758ms)","trace[1690732472] 'applied index is now lower than readState.Index'  (duration: 6.004647ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:10.388979Z","caller":"traceutil/trace.go:171","msg":"trace[1094587238] transaction","detail":"{read_only:false; response_revision:29038; number_of_response:1; }","duration":"298.979285ms","start":"2026-08-24T21:31:10.089971Z","end":"2026-08-24T21:31:10.388951Z","steps":["trace[1094587238] 'process raft request'  (duration: 292.924037ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.389251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.871252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11501"}
{"level":"info","ts":"2026-08-24T21:31:10.38944Z","caller":"traceutil/trace.go:171","msg":"trace[1859787403] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:29038; }","duration":"308.15879ms","start":"2026-08-24T21:31:10.081254Z","end":"2026-08-24T21:31:10.389412Z","steps":["trace[1859787403] 'agreement among raft nodes before linearized reading'  (duration: 307.724068ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.389814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.081235Z","time spent":"308.557549ms","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11523,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-08-24T21:31:10.421404Z","caller":"traceutil/trace.go:171","msg":"trace[1997297008] transaction","detail":"{read_only:false; response_revision:29040; number_of_response:1; }","duration":"239.085443ms","start":"2026-08-24T21:31:10.182291Z","end":"2026-08-24T21:31:10.421377Z","steps":["trace[1997297008] 'process raft request'  (duration: 238.95295ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.421432Z","caller":"traceutil/trace.go:171","msg":"trace[1844859254] transaction","detail":"{read_only:false; response_revision:29039; number_of_response:1; }","duration":"239.739111ms","start":"2026-08-24T21:31:10.181658Z","end":"2026-08-24T21:31:10.421397Z","steps":["trace[1844859254] 'process raft request'  (duration: 239.403213ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.42181Z","caller":"traceutil/trace.go:171","msg":"trace[364908160] transaction","detail":"{read_only:false; response_revision:29041; number_of_response:1; }","duration":"238.638143ms","start":"2026-08-24T21:31:10.183116Z","end":"2026-08-24T21:31:10.421754Z","steps":["trace[364908160] 'process raft request'  (duration: 238.200863ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.422055Z","caller":"traceutil/trace.go:171","msg":"trace[1714489965] transaction","detail":"{read_only:false; response_revision:29042; number_of_response:1; }","duration":"238.880799ms","start":"2026-08-24T21:31:10.183159Z","end":"2026-08-24T21:31:10.42204Z","steps":["trace[1714489965] 'process raft request'  (duration: 238.51514ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.422113Z","caller":"traceutil/trace.go:171","msg":"trace[2082330552] transaction","detail":"{read_only:false; response_revision:29043; number_of_response:1; }","duration":"236.473009ms","start":"2026-08-24T21:31:10.185622Z","end":"2026-08-24T21:31:10.422095Z","steps":["trace[2082330552] 'process raft request'  (duration: 236.290975ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.422364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.441071ms","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":"warn","ts":"2026-08-24T21:31:10.422365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.126924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-08-24T21:31:10.422463Z","caller":"traceutil/trace.go:171","msg":"trace[618579241] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:29043; }","duration":"241.539163ms","start":"2026-08-24T21:31:10.18088Z","end":"2026-08-24T21:31:10.422419Z","steps":["trace[618579241] 'agreement among raft nodes before linearized reading'  (duration: 241.300857ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.422454Z","caller":"traceutil/trace.go:171","msg":"trace[763034151] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:29043; }","duration":"114.253887ms","start":"2026-08-24T21:31:10.308176Z","end":"2026-08-24T21:31:10.42243Z","steps":["trace[763034151] 'agreement among raft nodes before linearized reading'  (duration: 114.062353ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.695361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.732291ms","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-24T21:31:10.695472Z","caller":"traceutil/trace.go:171","msg":"trace[1096775349] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:29046; }","duration":"205.891455ms","start":"2026-08-24T21:31:10.489552Z","end":"2026-08-24T21:31:10.695443Z","steps":["trace[1096775349] 'range keys from in-memory index tree'  (duration: 205.538836ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.695739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.130766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1515"}
{"level":"info","ts":"2026-08-24T21:31:10.695786Z","caller":"traceutil/trace.go:171","msg":"trace[328275898] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:29046; }","duration":"205.200697ms","start":"2026-08-24T21:31:10.490572Z","end":"2026-08-24T21:31:10.695773Z","steps":["trace[328275898] 'range keys from in-memory index tree'  (duration: 205.064934ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:10.695972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.869526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1515"}
{"level":"info","ts":"2026-08-24T21:31:10.696017Z","caller":"traceutil/trace.go:171","msg":"trace[1074584485] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:29046; }","duration":"201.928887ms","start":"2026-08-24T21:31:10.494077Z","end":"2026-08-24T21:31:10.696006Z","steps":["trace[1074584485] 'range keys from in-memory index tree'  (duration: 201.826565ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:10.797901Z","caller":"traceutil/trace.go:171","msg":"trace[1790888590] transaction","detail":"{read_only:false; response_revision:29047; number_of_response:1; }","duration":"279.695764ms","start":"2026-08-24T21:31:10.518174Z","end":"2026-08-24T21:31:10.79787Z","steps":["trace[1790888590] 'process raft request'  (duration: 279.53375ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.127975Z","caller":"traceutil/trace.go:171","msg":"trace[2045268776] transaction","detail":"{read_only:false; response_revision:29049; number_of_response:1; }","duration":"450.997935ms","start":"2026-08-24T21:31:10.67695Z","end":"2026-08-24T21:31:11.127948Z","steps":["trace[2045268776] 'process raft request'  (duration: 450.844731ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.128158Z","caller":"traceutil/trace.go:171","msg":"trace[1505375708] transaction","detail":"{read_only:false; response_revision:29051; number_of_response:1; }","duration":"427.430109ms","start":"2026-08-24T21:31:10.700713Z","end":"2026-08-24T21:31:11.128143Z","steps":["trace[1505375708] 'process raft request'  (duration: 427.201974ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.127975Z","caller":"traceutil/trace.go:171","msg":"trace[1034163830] transaction","detail":"{read_only:false; response_revision:29048; number_of_response:1; }","duration":"534.218074ms","start":"2026-08-24T21:31:10.593711Z","end":"2026-08-24T21:31:11.12793Z","steps":["trace[1034163830] 'process raft request'  (duration: 518.04793ms)","trace[1034163830] 'compare'  (duration: 15.239762ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:11.12823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.700686Z","time spent":"427.49893ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":536,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:29027 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:460 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:11.128232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.676927Z","time spent":"451.138888ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:29031 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-24T21:31:11.128359Z","caller":"traceutil/trace.go:171","msg":"trace[1694846581] linearizableReadLoop","detail":"{readStateIndex:30381; appliedIndex:30377; }","duration":"442.093557ms","start":"2026-08-24T21:31:10.686244Z","end":"2026-08-24T21:31:11.128337Z","steps":["trace[1694846581] 'read index received'  (duration: 111.395828ms)","trace[1694846581] 'applied index is now lower than readState.Index'  (duration: 330.696879ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:11.128375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.593675Z","time spent":"534.625004ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:29030 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-24T21:31:11.128446Z","caller":"traceutil/trace.go:171","msg":"trace[1558665165] transaction","detail":"{read_only:false; response_revision:29052; number_of_response:1; }","duration":"424.230621ms","start":"2026-08-24T21:31:10.704204Z","end":"2026-08-24T21:31:11.128435Z","steps":["trace[1558665165] 'process raft request'  (duration: 423.840442ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.128512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.704182Z","time spent":"424.287802ms","remote":"127.0.0.1:54536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1810,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" mod_revision:29046 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" value_size:1737 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:11.128516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.251691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:11.128582Z","caller":"traceutil/trace.go:171","msg":"trace[1772694136] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:29052; }","duration":"442.347472ms","start":"2026-08-24T21:31:10.686215Z","end":"2026-08-24T21:31:11.128562Z","steps":["trace[1772694136] 'agreement among raft nodes before linearized reading'  (duration: 442.23031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.128636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.686204Z","time spent":"442.415695ms","remote":"127.0.0.1:47642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "}
{"level":"info","ts":"2026-08-24T21:31:11.127993Z","caller":"traceutil/trace.go:171","msg":"trace[1320002413] transaction","detail":"{read_only:false; response_revision:29050; number_of_response:1; }","duration":"450.761609ms","start":"2026-08-24T21:31:10.677211Z","end":"2026-08-24T21:31:11.127973Z","steps":["trace[1320002413] 'process raft request'  (duration: 450.676957ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.128869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.677205Z","time spent":"451.623401ms","remote":"127.0.0.1:50326","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:29032 > 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-24T21:31:11.328571Z","caller":"traceutil/trace.go:171","msg":"trace[2060435403] linearizableReadLoop","detail":"{readStateIndex:30384; appliedIndex:30383; }","duration":"200.149355ms","start":"2026-08-24T21:31:11.128396Z","end":"2026-08-24T21:31:11.328545Z","steps":["trace[2060435403] 'read index received'  (duration: 200.065353ms)","trace[2060435403] 'applied index is now lower than readState.Index'  (duration: 82.692µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:11.329111Z","caller":"traceutil/trace.go:171","msg":"trace[1442406105] transaction","detail":"{read_only:false; number_of_response:0; response_revision:29052; }","duration":"523.35853ms","start":"2026-08-24T21:31:10.805714Z","end":"2026-08-24T21:31:11.329073Z","steps":["trace[1442406105] 'process raft request'  (duration: 522.748526ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.328848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.951036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:31:11.329412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.805682Z","time spent":"523.535865ms","remote":"127.0.0.1:50550","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" mod_revision:0 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" value_size:7315 >> failure:<>"}
{"level":"warn","ts":"2026-08-24T21:31:11.328908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.80572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:31:11.329064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.81186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:11.329948Z","caller":"traceutil/trace.go:171","msg":"trace[1641724673] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:29052; }","duration":"638.5084ms","start":"2026-08-24T21:31:10.690851Z","end":"2026-08-24T21:31:11.329359Z","steps":["trace[1641724673] 'agreement among raft nodes before linearized reading'  (duration: 637.936887ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.331312Z","caller":"traceutil/trace.go:171","msg":"trace[242259450] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:29052; }","duration":"458.507127ms","start":"2026-08-24T21:31:10.87106Z","end":"2026-08-24T21:31:11.329567Z","steps":["trace[242259450] 'agreement among raft nodes before linearized reading'  (duration: 457.821021ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.344608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.871047Z","time spent":"473.537685ms","remote":"127.0.0.1:58132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true "}
{"level":"info","ts":"2026-08-24T21:31:11.331942Z","caller":"traceutil/trace.go:171","msg":"trace[1775638382] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:29052; }","duration":"458.537847ms","start":"2026-08-24T21:31:10.87119Z","end":"2026-08-24T21:31:11.329728Z","steps":["trace[1775638382] 'agreement among raft nodes before linearized reading'  (duration: 457.560904ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.34463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.690843Z","time spent":"653.659591ms","remote":"127.0.0.1:47704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "}
{"level":"warn","ts":"2026-08-24T21:31:11.344698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:10.871163Z","time spent":"473.507074ms","remote":"127.0.0.1:47702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true "}
{"level":"warn","ts":"2026-08-24T21:31:11.341979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.166976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"warn","ts":"2026-08-24T21:31:11.342025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.564779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:11.344808Z","caller":"traceutil/trace.go:171","msg":"trace[1016375054] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:29053; }","duration":"199.017226ms","start":"2026-08-24T21:31:11.145754Z","end":"2026-08-24T21:31:11.344771Z","steps":["trace[1016375054] 'agreement among raft nodes before linearized reading'  (duration: 196.052914ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.344899Z","caller":"traceutil/trace.go:171","msg":"trace[613522846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29053; }","duration":"211.46115ms","start":"2026-08-24T21:31:11.133402Z","end":"2026-08-24T21:31:11.344863Z","steps":["trace[613522846] 'agreement among raft nodes before linearized reading'  (duration: 208.556589ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.341989Z","caller":"traceutil/trace.go:171","msg":"trace[1659500543] transaction","detail":"{read_only:false; response_revision:29053; number_of_response:1; }","duration":"202.591244ms","start":"2026-08-24T21:31:11.139341Z","end":"2026-08-24T21:31:11.341932Z","steps":["trace[1659500543] 'process raft request'  (duration: 201.791363ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.720724Z","caller":"traceutil/trace.go:171","msg":"trace[387242382] transaction","detail":"{read_only:false; response_revision:29054; number_of_response:1; }","duration":"369.807193ms","start":"2026-08-24T21:31:11.350869Z","end":"2026-08-24T21:31:11.720676Z","steps":["trace[387242382] 'process raft request'  (duration: 279.798187ms)","trace[387242382] 'compare'  (duration: 89.658238ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:11.721114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.350855Z","time spent":"369.967277ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1240,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" value_size:1176 >> failure:<>"}
{"level":"warn","ts":"2026-08-24T21:31:11.97165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.836573ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383505 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" mod_revision:29047 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" value_size:16783 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:31:11.972197Z","caller":"traceutil/trace.go:171","msg":"trace[722664140] transaction","detail":"{read_only:false; response_revision:29055; number_of_response:1; }","duration":"618.698997ms","start":"2026-08-24T21:31:11.353451Z","end":"2026-08-24T21:31:11.97215Z","steps":["trace[722664140] 'process raft request'  (duration: 496.253499ms)","trace[722664140] 'compare'  (duration: 121.648218ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:11.972589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.353423Z","time spent":"618.877951ms","remote":"127.0.0.1:50550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16844,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" mod_revision:29047 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" value_size:16783 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" > >"}
{"level":"info","ts":"2026-08-24T21:31:11.972787Z","caller":"traceutil/trace.go:171","msg":"trace[1926095358] transaction","detail":"{read_only:false; response_revision:29056; number_of_response:1; }","duration":"617.232892ms","start":"2026-08-24T21:31:11.355511Z","end":"2026-08-24T21:31:11.972743Z","steps":["trace[1926095358] 'process raft request'  (duration: 616.244947ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:11.97293Z","caller":"traceutil/trace.go:171","msg":"trace[1257771782] transaction","detail":"{read_only:false; response_revision:29057; number_of_response:1; }","duration":"591.444702ms","start":"2026-08-24T21:31:11.381463Z","end":"2026-08-24T21:31:11.972907Z","steps":["trace[1257771782] 'process raft request'  (duration: 590.896539ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.97304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.381438Z","time spent":"591.551574ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:29011 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:11.973126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.355489Z","time spent":"617.394575ms","remote":"127.0.0.1:50176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:29033 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-24T21:31:11.973226Z","caller":"traceutil/trace.go:171","msg":"trace[1319183528] linearizableReadLoop","detail":"{readStateIndex:30389; appliedIndex:30385; }","duration":"546.576107ms","start":"2026-08-24T21:31:11.426604Z","end":"2026-08-24T21:31:11.973181Z","steps":["trace[1319183528] 'read index received'  (duration: 204.08005ms)","trace[1319183528] 'applied index is now lower than readState.Index'  (duration: 342.494936ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:11.973339Z","caller":"traceutil/trace.go:171","msg":"trace[1499124234] transaction","detail":"{read_only:false; response_revision:29058; number_of_response:1; }","duration":"491.305908ms","start":"2026-08-24T21:31:11.48202Z","end":"2026-08-24T21:31:11.973326Z","steps":["trace[1499124234] 'process raft request'  (duration: 490.628462ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.973418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.481982Z","time spent":"491.39724ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:29035 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:11.973429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.832033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:11.973499Z","caller":"traceutil/trace.go:171","msg":"trace[1640620598] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:29058; }","duration":"546.938865ms","start":"2026-08-24T21:31:11.426521Z","end":"2026-08-24T21:31:11.97346Z","steps":["trace[1640620598] 'agreement among raft nodes before linearized reading'  (duration: 546.809672ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:11.973551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.426488Z","time spent":"547.050358ms","remote":"127.0.0.1:58330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-08-24T21:31:12.194949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.890304ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383509 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:28969 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:31:12.195188Z","caller":"traceutil/trace.go:171","msg":"trace[67110341] transaction","detail":"{read_only:false; response_revision:29059; number_of_response:1; }","duration":"557.620806ms","start":"2026-08-24T21:31:11.637526Z","end":"2026-08-24T21:31:12.195147Z","steps":["trace[67110341] 'process raft request'  (duration: 451.423985ms)","trace[67110341] 'compare'  (duration: 105.556166ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:12.195298Z","caller":"traceutil/trace.go:171","msg":"trace[1719038999] linearizableReadLoop","detail":"{readStateIndex:30394; appliedIndex:30390; }","duration":"222.003906ms","start":"2026-08-24T21:31:11.973276Z","end":"2026-08-24T21:31:12.19528Z","steps":["trace[1719038999] 'read index received'  (duration: 115.672442ms)","trace[1719038999] 'applied index is now lower than readState.Index'  (duration: 106.330244ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:12.195383Z","caller":"traceutil/trace.go:171","msg":"trace[891063100] transaction","detail":"{read_only:false; response_revision:29062; number_of_response:1; }","duration":"466.982234ms","start":"2026-08-24T21:31:11.72839Z","end":"2026-08-24T21:31:12.195373Z","steps":["trace[891063100] 'process raft request'  (duration: 466.83696ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.195439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.72838Z","time spent":"467.029626ms","remote":"127.0.0.1:50340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1237,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-8fzd9\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-8fzd9\" value_size:1167 >> failure:<>"}
{"level":"info","ts":"2026-08-24T21:31:12.195453Z","caller":"traceutil/trace.go:171","msg":"trace[1699871877] transaction","detail":"{read_only:false; response_revision:29060; number_of_response:1; }","duration":"468.151873ms","start":"2026-08-24T21:31:11.727263Z","end":"2026-08-24T21:31:12.195415Z","steps":["trace[1699871877] 'process raft request'  (duration: 467.797034ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:12.195481Z","caller":"traceutil/trace.go:171","msg":"trace[674938368] transaction","detail":"{read_only:false; response_revision:29061; number_of_response:1; }","duration":"467.683352ms","start":"2026-08-24T21:31:11.727764Z","end":"2026-08-24T21:31:12.195447Z","steps":["trace[674938368] 'process raft request'  (duration: 467.406355ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.195592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.727236Z","time spent":"468.291246ms","remote":"127.0.0.1:50230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":744,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-manila-nodes\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila-nodes\" value_size:676 >> failure:<>"}
{"level":"warn","ts":"2026-08-24T21:31:12.195565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.310102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:31:12.195643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.727738Z","time spent":"467.827165ms","remote":"127.0.0.1:50158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18cedb291c209aa8\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18cedb291c209aa8\" value_size:595 lease:2297856386583607637 >> failure:<>"}
{"level":"info","ts":"2026-08-24T21:31:12.19567Z","caller":"traceutil/trace.go:171","msg":"trace[1825405157] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:29062; }","duration":"667.474726ms","start":"2026-08-24T21:31:11.52817Z","end":"2026-08-24T21:31:12.195645Z","steps":["trace[1825405157] 'agreement among raft nodes before linearized reading'  (duration: 667.252301ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.195642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.405245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:31:12.195793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.52814Z","time spent":"667.63814ms","remote":"127.0.0.1:58088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true "}
{"level":"info","ts":"2026-08-24T21:31:12.195822Z","caller":"traceutil/trace.go:171","msg":"trace[948023520] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:29062; }","duration":"708.642572ms","start":"2026-08-24T21:31:11.487147Z","end":"2026-08-24T21:31:12.19579Z","steps":["trace[948023520] 'agreement among raft nodes before linearized reading'  (duration: 708.340535ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.195696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.0266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129891"}
{"level":"warn","ts":"2026-08-24T21:31:12.195881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.487126Z","time spent":"708.744004ms","remote":"127.0.0.1:57960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true "}
{"level":"info","ts":"2026-08-24T21:31:12.195901Z","caller":"traceutil/trace.go:171","msg":"trace[603986768] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:29062; }","duration":"468.260116ms","start":"2026-08-24T21:31:11.727623Z","end":"2026-08-24T21:31:12.195884Z","steps":["trace[603986768] 'agreement among raft nodes before linearized reading'  (duration: 467.809275ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.195952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.727569Z","time spent":"468.362739ms","remote":"127.0.0.1:50132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":129913,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-08-24T21:31:12.196042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.637499Z","time spent":"557.7621ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:28969 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:12.507206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.474914ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383514 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:29037 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:31:12.507528Z","caller":"traceutil/trace.go:171","msg":"trace[566543398] transaction","detail":"{read_only:false; response_revision:29064; number_of_response:1; }","duration":"308.333804ms","start":"2026-08-24T21:31:12.199179Z","end":"2026-08-24T21:31:12.507513Z","steps":["trace[566543398] 'process raft request'  (duration: 308.1726ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.507587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:12.19914Z","time spent":"308.423786ms","remote":"127.0.0.1:50132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":129875,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:28674 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:129838 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"info","ts":"2026-08-24T21:31:12.507596Z","caller":"traceutil/trace.go:171","msg":"trace[2131840745] transaction","detail":"{read_only:false; response_revision:29063; number_of_response:1; }","duration":"322.612232ms","start":"2026-08-24T21:31:12.184921Z","end":"2026-08-24T21:31:12.507534Z","steps":["trace[2131840745] 'process raft request'  (duration: 132.702617ms)","trace[2131840745] 'compare'  (duration: 189.32494ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:12.507729Z","caller":"traceutil/trace.go:171","msg":"trace[1429605699] linearizableReadLoop","detail":"{readStateIndex:30395; appliedIndex:30394; }","duration":"312.348072ms","start":"2026-08-24T21:31:12.195334Z","end":"2026-08-24T21:31:12.507682Z","steps":["trace[1429605699] 'read index received'  (duration: 122.386647ms)","trace[1429605699] 'applied index is now lower than readState.Index'  (duration: 189.958245ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:12.507807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:12.184878Z","time spent":"322.809506ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:29037 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:12.507837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.325155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11501"}
{"level":"warn","ts":"2026-08-24T21:31:12.507789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.7815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:12.507888Z","caller":"traceutil/trace.go:171","msg":"trace[111550555] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:29064; }","duration":"506.417538ms","start":"2026-08-24T21:31:12.001453Z","end":"2026-08-24T21:31:12.507871Z","steps":["trace[111550555] 'agreement among raft nodes before linearized reading'  (duration: 506.233253ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.507911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.617998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:569"}
{"level":"info","ts":"2026-08-24T21:31:12.507916Z","caller":"traceutil/trace.go:171","msg":"trace[544041496] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:29064; }","duration":"523.929844ms","start":"2026-08-24T21:31:11.983964Z","end":"2026-08-24T21:31:12.507893Z","steps":["trace[544041496] 'agreement among raft nodes before linearized reading'  (duration: 523.792551ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.507934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:12.001426Z","time spent":"506.500579ms","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11523,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-24T21:31:12.507908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.229222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-24T21:31:12.507968Z","caller":"traceutil/trace.go:171","msg":"trace[1951401962] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:29064; }","duration":"530.716621ms","start":"2026-08-24T21:31:11.977236Z","end":"2026-08-24T21:31:12.507953Z","steps":["trace[1951401962] 'agreement among raft nodes before linearized reading'  (duration: 530.583237ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:12.508003Z","caller":"traceutil/trace.go:171","msg":"trace[732823139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29064; }","duration":"424.546509ms","start":"2026-08-24T21:31:12.083435Z","end":"2026-08-24T21:31:12.507982Z","steps":["trace[732823139] 'agreement among raft nodes before linearized reading'  (duration: 424.270723ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:12.508009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.97721Z","time spent":"530.789983ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":591,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-24T21:31:12.508019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:11.983944Z","time spent":"524.030897ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-08-24T21:31:12.508053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:12.083413Z","time spent":"424.629372ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-24T21:31:12.525315Z","caller":"traceutil/trace.go:171","msg":"trace[25406416] transaction","detail":"{read_only:false; response_revision:29065; number_of_response:1; }","duration":"116.095693ms","start":"2026-08-24T21:31:12.409157Z","end":"2026-08-24T21:31:12.525252Z","steps":["trace[25406416] 'process raft request'  (duration: 115.636812ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:13.783221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.666843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:13.783314Z","caller":"traceutil/trace.go:171","msg":"trace[435469440] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:29128; }","duration":"106.828117ms","start":"2026-08-24T21:31:13.676462Z","end":"2026-08-24T21:31:13.78329Z","steps":["trace[435469440] 'count revisions from in-memory index tree'  (duration: 106.56388ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:16.255585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.418857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:16.255754Z","caller":"traceutil/trace.go:171","msg":"trace[63286788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29146; }","duration":"122.601272ms","start":"2026-08-24T21:31:16.13309Z","end":"2026-08-24T21:31:16.255691Z","steps":["trace[63286788] 'range keys from in-memory index tree'  (duration: 122.309295ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:20.149654Z","caller":"traceutil/trace.go:171","msg":"trace[1995328819] transaction","detail":"{read_only:false; response_revision:29204; number_of_response:1; }","duration":"110.901537ms","start":"2026-08-24T21:31:20.038726Z","end":"2026-08-24T21:31:20.149628Z","steps":["trace[1995328819] 'process raft request'  (duration: 110.689902ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:20.503124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.281346ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438383893 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:29175 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:31:20.503246Z","caller":"traceutil/trace.go:171","msg":"trace[548324624] linearizableReadLoop","detail":"{readStateIndex:30541; appliedIndex:30540; }","duration":"370.930001ms","start":"2026-08-24T21:31:20.132299Z","end":"2026-08-24T21:31:20.503229Z","steps":["trace[548324624] 'read index received'  (duration: 17.301732ms)","trace[548324624] 'applied index is now lower than readState.Index'  (duration: 353.626979ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:20.503287Z","caller":"traceutil/trace.go:171","msg":"trace[686944821] transaction","detail":"{read_only:false; response_revision:29205; number_of_response:1; }","duration":"451.547008ms","start":"2026-08-24T21:31:20.051716Z","end":"2026-08-24T21:31:20.503263Z","steps":["trace[686944821] 'process raft request'  (duration: 231.028837ms)","trace[686944821] 'compare'  (duration: 219.444155ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:20.503361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:20.051686Z","time spent":"451.63727ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:29175 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-24T21:31:20.503418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.134777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:20.503515Z","caller":"traceutil/trace.go:171","msg":"trace[1667112226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29205; }","duration":"371.307491ms","start":"2026-08-24T21:31:20.13218Z","end":"2026-08-24T21:31:20.503488Z","steps":["trace[1667112226] 'agreement among raft nodes before linearized reading'  (duration: 371.112446ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:20.503522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.675429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-24T21:31:20.503559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:31:20.132157Z","time spent":"371.392962ms","remote":"127.0.0.1:50076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-24T21:31:20.503568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.672595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-08-24T21:31:20.50361Z","caller":"traceutil/trace.go:171","msg":"trace[1066510111] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:29205; }","duration":"112.839083ms","start":"2026-08-24T21:31:20.390751Z","end":"2026-08-24T21:31:20.50359Z","steps":["trace[1066510111] 'agreement among raft nodes before linearized reading'  (duration: 112.654839ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:20.503656Z","caller":"traceutil/trace.go:171","msg":"trace[1075752290] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:29205; }","duration":"186.821128ms","start":"2026-08-24T21:31:20.316813Z","end":"2026-08-24T21:31:20.503634Z","steps":["trace[1075752290] 'agreement among raft nodes before linearized reading'  (duration: 186.545682ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:56.994322Z","caller":"traceutil/trace.go:171","msg":"trace[1736915020] transaction","detail":"{read_only:false; response_revision:29541; number_of_response:1; }","duration":"144.019666ms","start":"2026-08-24T21:31:56.850271Z","end":"2026-08-24T21:31:56.99429Z","steps":["trace[1736915020] 'process raft request'  (duration: 126.527128ms)","trace[1736915020] 'compare'  (duration: 16.73646ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:57.296919Z","caller":"traceutil/trace.go:171","msg":"trace[1179475317] transaction","detail":"{read_only:false; response_revision:29542; number_of_response:1; }","duration":"296.951733ms","start":"2026-08-24T21:31:56.999918Z","end":"2026-08-24T21:31:57.29687Z","steps":["trace[1179475317] 'process raft request'  (duration: 236.596795ms)","trace[1179475317] 'compare'  (duration: 60.128392ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:57.297303Z","caller":"traceutil/trace.go:171","msg":"trace[1791326290] transaction","detail":"{read_only:false; response_revision:29543; number_of_response:1; }","duration":"297.341862ms","start":"2026-08-24T21:31:56.999922Z","end":"2026-08-24T21:31:57.297264Z","steps":["trace[1791326290] 'process raft request'  (duration: 296.897262ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.297338Z","caller":"traceutil/trace.go:171","msg":"trace[551944667] linearizableReadLoop","detail":"{readStateIndex:30898; appliedIndex:30891; }","duration":"162.868809ms","start":"2026-08-24T21:31:57.134441Z","end":"2026-08-24T21:31:57.29731Z","steps":["trace[551944667] 'read index received'  (duration: 102.094531ms)","trace[551944667] 'applied index is now lower than readState.Index'  (duration: 60.772748ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:31:57.297475Z","caller":"traceutil/trace.go:171","msg":"trace[2104602123] transaction","detail":"{read_only:false; response_revision:29547; number_of_response:1; }","duration":"295.520087ms","start":"2026-08-24T21:31:57.001944Z","end":"2026-08-24T21:31:57.297464Z","steps":["trace[2104602123] 'process raft request'  (duration: 295.270041ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.297507Z","caller":"traceutil/trace.go:171","msg":"trace[1130362858] transaction","detail":"{read_only:false; response_revision:29546; number_of_response:1; }","duration":"295.922097ms","start":"2026-08-24T21:31:57.001529Z","end":"2026-08-24T21:31:57.297452Z","steps":["trace[1130362858] 'process raft request'  (duration: 295.64511ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:31:57.297569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.108404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:57.297608Z","caller":"traceutil/trace.go:171","msg":"trace[1523506181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29548; }","duration":"163.167145ms","start":"2026-08-24T21:31:57.134429Z","end":"2026-08-24T21:31:57.297596Z","steps":["trace[1523506181] 'agreement among raft nodes before linearized reading'  (duration: 163.087614ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.297661Z","caller":"traceutil/trace.go:171","msg":"trace[1597886437] transaction","detail":"{read_only:false; response_revision:29544; number_of_response:1; }","duration":"297.65935ms","start":"2026-08-24T21:31:56.999993Z","end":"2026-08-24T21:31:57.297653Z","steps":["trace[1597886437] 'process raft request'  (duration: 297.011464ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.297753Z","caller":"traceutil/trace.go:171","msg":"trace[1453908447] transaction","detail":"{read_only:false; response_revision:29545; number_of_response:1; }","duration":"297.68182ms","start":"2026-08-24T21:31:57.00006Z","end":"2026-08-24T21:31:57.297742Z","steps":["trace[1453908447] 'process raft request'  (duration: 297.073925ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.298097Z","caller":"traceutil/trace.go:171","msg":"trace[1766352961] transaction","detail":"{read_only:false; response_revision:29548; number_of_response:1; }","duration":"235.381614ms","start":"2026-08-24T21:31:57.062669Z","end":"2026-08-24T21:31:57.298051Z","steps":["trace[1766352961] 'process raft request'  (duration: 234.591375ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.479254Z","caller":"traceutil/trace.go:171","msg":"trace[2019682987] transaction","detail":"{read_only:false; response_revision:29549; number_of_response:1; }","duration":"171.576882ms","start":"2026-08-24T21:31:57.30763Z","end":"2026-08-24T21:31:57.479207Z","steps":["trace[2019682987] 'process raft request'  (duration: 171.332327ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.479928Z","caller":"traceutil/trace.go:171","msg":"trace[196672112] linearizableReadLoop","detail":"{readStateIndex:30900; appliedIndex:30898; }","duration":"118.369169ms","start":"2026-08-24T21:31:57.361523Z","end":"2026-08-24T21:31:57.479892Z","steps":["trace[196672112] 'read index received'  (duration: 117.512618ms)","trace[196672112] 'applied index is now lower than readState.Index'  (duration: 855.211µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:31:57.480184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.631285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:31:57.480246Z","caller":"traceutil/trace.go:171","msg":"trace[186527211] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:29550; }","duration":"118.716758ms","start":"2026-08-24T21:31:57.361503Z","end":"2026-08-24T21:31:57.48022Z","steps":["trace[186527211] 'agreement among raft nodes before linearized reading'  (duration: 118.536883ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:31:57.480798Z","caller":"traceutil/trace.go:171","msg":"trace[198195812] transaction","detail":"{read_only:false; response_revision:29550; number_of_response:1; }","duration":"154.681169ms","start":"2026-08-24T21:31:57.326104Z","end":"2026-08-24T21:31:57.480786Z","steps":["trace[198195812] 'process raft request'  (duration: 153.617203ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:02.86167Z","caller":"traceutil/trace.go:171","msg":"trace[1507807100] linearizableReadLoop","detail":"{readStateIndex:30944; appliedIndex:30943; }","duration":"117.062396ms","start":"2026-08-24T21:32:02.744574Z","end":"2026-08-24T21:32:02.861636Z","steps":["trace[1507807100] 'read index received'  (duration: 116.842471ms)","trace[1507807100] 'applied index is now lower than readState.Index'  (duration: 218.015µs)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:02.861752Z","caller":"traceutil/trace.go:171","msg":"trace[182844274] transaction","detail":"{read_only:false; response_revision:29592; number_of_response:1; }","duration":"118.817671ms","start":"2026-08-24T21:32:02.742883Z","end":"2026-08-24T21:32:02.861701Z","steps":["trace[182844274] 'process raft request'  (duration: 118.558683ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:02.861829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.229141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:32:02.86213Z","caller":"traceutil/trace.go:171","msg":"trace[755846409] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:29592; }","duration":"117.553769ms","start":"2026-08-24T21:32:02.744523Z","end":"2026-08-24T21:32:02.862077Z","steps":["trace[755846409] 'agreement among raft nodes before linearized reading'  (duration: 117.232401ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:03.52403Z","caller":"traceutil/trace.go:171","msg":"trace[1665939205] transaction","detail":"{read_only:false; response_revision:29595; number_of_response:1; }","duration":"193.472118ms","start":"2026-08-24T21:32:03.330501Z","end":"2026-08-24T21:32:03.523974Z","steps":["trace[1665939205] 'process raft request'  (duration: 93.753675ms)","trace[1665939205] 'compare'  (duration: 99.248822ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:03.524355Z","caller":"traceutil/trace.go:171","msg":"trace[2051221333] transaction","detail":"{read_only:false; response_revision:29596; number_of_response:1; }","duration":"192.800082ms","start":"2026-08-24T21:32:03.331511Z","end":"2026-08-24T21:32:03.524311Z","steps":["trace[2051221333] 'process raft request'  (duration: 192.385162ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:03.524609Z","caller":"traceutil/trace.go:171","msg":"trace[372512286] linearizableReadLoop","detail":"{readStateIndex:30949; appliedIndex:30946; }","duration":"192.376862ms","start":"2026-08-24T21:32:03.332198Z","end":"2026-08-24T21:32:03.524575Z","steps":["trace[372512286] 'read index received'  (duration: 91.997583ms)","trace[372512286] 'applied index is now lower than readState.Index'  (duration: 100.377649ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:03.524685Z","caller":"traceutil/trace.go:171","msg":"trace[2027246253] transaction","detail":"{read_only:false; response_revision:29597; number_of_response:1; }","duration":"192.685569ms","start":"2026-08-24T21:32:03.331961Z","end":"2026-08-24T21:32:03.524646Z","steps":["trace[2027246253] 'process raft request'  (duration: 192.183777ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:03.524904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.680679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-08-24T21:32:03.524959Z","caller":"traceutil/trace.go:171","msg":"trace[1899990586] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:29597; }","duration":"192.852164ms","start":"2026-08-24T21:32:03.332094Z","end":"2026-08-24T21:32:03.524946Z","steps":["trace[1899990586] 'agreement among raft nodes before linearized reading'  (duration: 192.662279ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:03.540549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.219469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-24T21:32:03.540612Z","caller":"traceutil/trace.go:171","msg":"trace[2105708626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29599; }","duration":"208.328512ms","start":"2026-08-24T21:32:03.332267Z","end":"2026-08-24T21:32:03.540595Z","steps":["trace[2105708626] 'agreement among raft nodes before linearized reading'  (duration: 208.155968ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:03.540966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.143547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-24T21:32:03.541006Z","caller":"traceutil/trace.go:171","msg":"trace[1864012346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29599; }","duration":"208.225889ms","start":"2026-08-24T21:32:03.332769Z","end":"2026-08-24T21:32:03.540994Z","steps":["trace[1864012346] 'agreement among raft nodes before linearized reading'  (duration: 208.031764ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:09.214679Z","caller":"traceutil/trace.go:171","msg":"trace[435642174] transaction","detail":"{read_only:false; response_revision:29645; number_of_response:1; }","duration":"145.953524ms","start":"2026-08-24T21:32:09.068692Z","end":"2026-08-24T21:32:09.214646Z","steps":["trace[435642174] 'process raft request'  (duration: 117.527198ms)","trace[435642174] 'compare'  (duration: 28.079248ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:10.151082Z","caller":"traceutil/trace.go:171","msg":"trace[1726316269] transaction","detail":"{read_only:false; response_revision:29659; number_of_response:1; }","duration":"184.069048ms","start":"2026-08-24T21:32:09.966976Z","end":"2026-08-24T21:32:10.151045Z","steps":["trace[1726316269] 'process raft request'  (duration: 183.77266ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:10.861422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.987155ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438385028 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:29535 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:32:10.861518Z","caller":"traceutil/trace.go:171","msg":"trace[1212782403] linearizableReadLoop","detail":"{readStateIndex:31018; appliedIndex:31017; }","duration":"131.615163ms","start":"2026-08-24T21:32:10.729889Z","end":"2026-08-24T21:32:10.861504Z","steps":["trace[1212782403] 'read index received'  (duration: 45.881µs)","trace[1212782403] 'applied index is now lower than readState.Index'  (duration: 131.567932ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:10.86161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.719836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:32:10.861639Z","caller":"traceutil/trace.go:171","msg":"trace[567318624] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:29662; }","duration":"131.798517ms","start":"2026-08-24T21:32:10.729833Z","end":"2026-08-24T21:32:10.861631Z","steps":["trace[567318624] 'agreement among raft nodes before linearized reading'  (duration: 131.707145ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:10.861695Z","caller":"traceutil/trace.go:171","msg":"trace[541336610] transaction","detail":"{read_only:false; response_revision:29662; number_of_response:1; }","duration":"395.071596ms","start":"2026-08-24T21:32:10.466572Z","end":"2026-08-24T21:32:10.861644Z","steps":["trace[541336610] 'process raft request'  (duration: 119.768743ms)","trace[541336610] 'compare'  (duration: 274.239897ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:10.861919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:32:10.466546Z","time spent":"395.24788ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:29535 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-08-24T21:32:11.369281Z","caller":"traceutil/trace.go:171","msg":"trace[1888492020] transaction","detail":"{read_only:false; response_revision:29664; number_of_response:1; }","duration":"147.998344ms","start":"2026-08-24T21:32:11.221251Z","end":"2026-08-24T21:32:11.36925Z","steps":["trace[1888492020] 'process raft request'  (duration: 147.776369ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:11.832413Z","caller":"traceutil/trace.go:171","msg":"trace[822380963] transaction","detail":"{read_only:false; response_revision:29666; number_of_response:1; }","duration":"265.00109ms","start":"2026-08-24T21:32:11.567379Z","end":"2026-08-24T21:32:11.83238Z","steps":["trace[822380963] 'process raft request'  (duration: 263.323359ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:11.832778Z","caller":"traceutil/trace.go:171","msg":"trace[1401479350] transaction","detail":"{read_only:false; response_revision:29668; number_of_response:1; }","duration":"263.255407ms","start":"2026-08-24T21:32:11.569484Z","end":"2026-08-24T21:32:11.832739Z","steps":["trace[1401479350] 'process raft request'  (duration: 263.070493ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:11.832752Z","caller":"traceutil/trace.go:171","msg":"trace[1048047686] transaction","detail":"{read_only:false; response_revision:29667; number_of_response:1; }","duration":"264.17705ms","start":"2026-08-24T21:32:11.568507Z","end":"2026-08-24T21:32:11.832684Z","steps":["trace[1048047686] 'process raft request'  (duration: 263.78963ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:11.832841Z","caller":"traceutil/trace.go:171","msg":"trace[1057764550] transaction","detail":"{read_only:false; response_revision:29669; number_of_response:1; }","duration":"261.409752ms","start":"2026-08-24T21:32:11.571402Z","end":"2026-08-24T21:32:11.832812Z","steps":["trace[1057764550] 'process raft request'  (duration: 261.246108ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:11.832771Z","caller":"traceutil/trace.go:171","msg":"trace[522966790] linearizableReadLoop","detail":"{readStateIndex:31024; appliedIndex:31020; }","duration":"262.334375ms","start":"2026-08-24T21:32:11.570403Z","end":"2026-08-24T21:32:11.832737Z","steps":["trace[522966790] 'read index received'  (duration: 29.620745ms)","trace[522966790] 'applied index is now lower than readState.Index'  (duration: 232.71202ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:11.833007Z","caller":"traceutil/trace.go:171","msg":"trace[1959542443] transaction","detail":"{read_only:false; response_revision:29670; number_of_response:1; }","duration":"255.029076ms","start":"2026-08-24T21:32:11.57797Z","end":"2026-08-24T21:32:11.832999Z","steps":["trace[1959542443] 'process raft request'  (duration: 254.719789ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:11.833045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.620843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-08-24T21:32:11.833099Z","caller":"traceutil/trace.go:171","msg":"trace[276296846] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:29670; }","duration":"262.718644ms","start":"2026-08-24T21:32:11.570366Z","end":"2026-08-24T21:32:11.833084Z","steps":["trace[276296846] 'agreement among raft nodes before linearized reading'  (duration: 262.484169ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:11.833184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.170337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-08-24T21:32:11.833249Z","caller":"traceutil/trace.go:171","msg":"trace[1238504078] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:29670; }","duration":"201.28121ms","start":"2026-08-24T21:32:11.631945Z","end":"2026-08-24T21:32:11.833227Z","steps":["trace[1238504078] 'agreement among raft nodes before linearized reading'  (duration: 201.115846ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:11.833257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.854567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-08-24T21:32:11.833295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.228908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-24T21:32:11.833317Z","caller":"traceutil/trace.go:171","msg":"trace[446149151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29670; }","duration":"254.000971ms","start":"2026-08-24T21:32:11.579294Z","end":"2026-08-24T21:32:11.833295Z","steps":["trace[446149151] 'agreement among raft nodes before linearized reading'  (duration: 253.760546ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:11.833329Z","caller":"traceutil/trace.go:171","msg":"trace[509130011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29670; }","duration":"250.29535ms","start":"2026-08-24T21:32:11.583022Z","end":"2026-08-24T21:32:11.833318Z","steps":["trace[509130011] 'agreement among raft nodes before linearized reading'  (duration: 250.157627ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:12.087095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.562019ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438385045 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:29655 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:32:12.087299Z","caller":"traceutil/trace.go:171","msg":"trace[1242970954] transaction","detail":"{read_only:false; response_revision:29673; number_of_response:1; }","duration":"247.513582ms","start":"2026-08-24T21:32:11.839772Z","end":"2026-08-24T21:32:12.087285Z","steps":["trace[1242970954] 'process raft request'  (duration: 247.486461ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:12.087318Z","caller":"traceutil/trace.go:171","msg":"trace[1922989001] linearizableReadLoop","detail":"{readStateIndex:31027; appliedIndex:31026; }","duration":"248.763812ms","start":"2026-08-24T21:32:11.838523Z","end":"2026-08-24T21:32:12.087287Z","steps":["trace[1922989001] 'read index received'  (duration: 110.823174ms)","trace[1922989001] 'applied index is now lower than readState.Index'  (duration: 137.938428ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:12.087574Z","caller":"traceutil/trace.go:171","msg":"trace[883073133] transaction","detail":"{read_only:false; response_revision:29672; number_of_response:1; }","duration":"248.353713ms","start":"2026-08-24T21:32:11.839212Z","end":"2026-08-24T21:32:12.087566Z","steps":["trace[883073133] 'process raft request'  (duration: 247.971834ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:12.08761Z","caller":"traceutil/trace.go:171","msg":"trace[796706517] transaction","detail":"{read_only:false; response_revision:29671; number_of_response:1; }","duration":"249.08009ms","start":"2026-08-24T21:32:11.83848Z","end":"2026-08-24T21:32:12.087561Z","steps":["trace[796706517] 'process raft request'  (duration: 110.938047ms)","trace[796706517] 'compare'  (duration: 137.20879ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:12.087981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.444139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"}
{"level":"info","ts":"2026-08-24T21:32:12.088041Z","caller":"traceutil/trace.go:171","msg":"trace[2136074984] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:29673; }","duration":"249.528141ms","start":"2026-08-24T21:32:11.83849Z","end":"2026-08-24T21:32:12.088018Z","steps":["trace[2136074984] 'agreement among raft nodes before linearized reading'  (duration: 249.304025ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:12.267817Z","caller":"traceutil/trace.go:171","msg":"trace[667116610] transaction","detail":"{read_only:false; response_revision:29675; number_of_response:1; }","duration":"127.308417ms","start":"2026-08-24T21:32:12.140471Z","end":"2026-08-24T21:32:12.267779Z","steps":["trace[667116610] 'process raft request'  (duration: 113.643002ms)","trace[667116610] 'compare'  (duration: 12.510187ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:12.688676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.004196ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438385059 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:29628 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:32:12.68883Z","caller":"traceutil/trace.go:171","msg":"trace[1749756073] linearizableReadLoop","detail":"{readStateIndex:31033; appliedIndex:31032; }","duration":"355.436114ms","start":"2026-08-24T21:32:12.333365Z","end":"2026-08-24T21:32:12.688801Z","steps":["trace[1749756073] 'read index received'  (duration: 133.14226ms)","trace[1749756073] 'applied index is now lower than readState.Index'  (duration: 222.291744ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:12.689043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.557591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-08-24T21:32:12.689116Z","caller":"traceutil/trace.go:171","msg":"trace[77598688] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0; range_end:; response_count:1; response_revision:29677; }","duration":"369.692444ms","start":"2026-08-24T21:32:12.319414Z","end":"2026-08-24T21:32:12.689106Z","steps":["trace[77598688] 'agreement among raft nodes before linearized reading'  (duration: 369.457058ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:12.689151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:32:12.319389Z","time spent":"369.750245ms","remote":"127.0.0.1:50228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":1588,"request content":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0\" "}
{"level":"warn","ts":"2026-08-24T21:32:12.689146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.952259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-24T21:32:12.689081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.036013ms","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-24T21:32:12.689312Z","caller":"traceutil/trace.go:171","msg":"trace[1603978520] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:29677; }","duration":"352.305018ms","start":"2026-08-24T21:32:12.336999Z","end":"2026-08-24T21:32:12.689304Z","steps":["trace[1603978520] 'agreement among raft nodes before linearized reading'  (duration: 351.933969ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:12.689333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:32:12.336975Z","time spent":"352.351ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-24T21:32:12.689183Z","caller":"traceutil/trace.go:171","msg":"trace[364199111] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:29677; }","duration":"265.035941ms","start":"2026-08-24T21:32:12.424136Z","end":"2026-08-24T21:32:12.689172Z","steps":["trace[364199111] 'agreement among raft nodes before linearized reading'  (duration: 264.97602ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:12.689445Z","caller":"traceutil/trace.go:171","msg":"trace[1540224360] transaction","detail":"{read_only:false; response_revision:29677; number_of_response:1; }","duration":"369.368196ms","start":"2026-08-24T21:32:12.319456Z","end":"2026-08-24T21:32:12.688824Z","steps":["trace[1540224360] 'process raft request'  (duration: 147.113683ms)","trace[1540224360] 'compare'  (duration: 221.857863ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:12.689608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:32:12.319428Z","time spent":"370.097374ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:29628 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-24T21:32:12.925303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.465163ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438385064 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:29660 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:460 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:32:12.925668Z","caller":"traceutil/trace.go:171","msg":"trace[708918709] transaction","detail":"{read_only:false; response_revision:29679; number_of_response:1; }","duration":"208.910927ms","start":"2026-08-24T21:32:12.71673Z","end":"2026-08-24T21:32:12.925641Z","steps":["trace[708918709] 'process raft request'  (duration: 208.681111ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:12.925679Z","caller":"traceutil/trace.go:171","msg":"trace[369559120] transaction","detail":"{read_only:false; response_revision:29678; number_of_response:1; }","duration":"231.579912ms","start":"2026-08-24T21:32:12.694067Z","end":"2026-08-24T21:32:12.925647Z","steps":["trace[369559120] 'process raft request'  (duration: 125.824292ms)","trace[369559120] 'compare'  (duration: 105.117255ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:18.270324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.897845ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438385204 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.223\" mod_revision:29642 > success:<request_put:<key:\"/registry/masterleases/199.204.45.223\" value_size:68 lease:2297856386583609393 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.223\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:32:18.270447Z","caller":"traceutil/trace.go:171","msg":"trace[336786617] linearizableReadLoop","detail":"{readStateIndex:31093; appliedIndex:31092; }","duration":"155.745145ms","start":"2026-08-24T21:32:18.114684Z","end":"2026-08-24T21:32:18.270429Z","steps":["trace[336786617] 'read index received'  (duration: 4.627934ms)","trace[336786617] 'applied index is now lower than readState.Index'  (duration: 151.115441ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:18.270575Z","caller":"traceutil/trace.go:171","msg":"trace[1119483031] transaction","detail":"{read_only:false; response_revision:29733; number_of_response:1; }","duration":"233.319234ms","start":"2026-08-24T21:32:18.037181Z","end":"2026-08-24T21:32:18.270501Z","steps":["trace[1119483031] 'process raft request'  (duration: 82.135662ms)","trace[1119483031] 'compare'  (duration: 150.388513ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:18.270788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.104723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-08-24T21:32:18.270863Z","caller":"traceutil/trace.go:171","msg":"trace[1586117211] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:29733; }","duration":"156.220666ms","start":"2026-08-24T21:32:18.114621Z","end":"2026-08-24T21:32:18.270842Z","steps":["trace[1586117211] 'agreement among raft nodes before linearized reading'  (duration: 155.937399ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:18.271317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.366259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-08-24T21:32:18.271362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.02395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-24T21:32:18.271382Z","caller":"traceutil/trace.go:171","msg":"trace[1047523912] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29733; }","duration":"156.489992ms","start":"2026-08-24T21:32:18.114877Z","end":"2026-08-24T21:32:18.271367Z","steps":["trace[1047523912] 'agreement among raft nodes before linearized reading'  (duration: 156.225196ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:18.271408Z","caller":"traceutil/trace.go:171","msg":"trace[1944348142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29733; }","duration":"156.109612ms","start":"2026-08-24T21:32:18.115287Z","end":"2026-08-24T21:32:18.271396Z","steps":["trace[1944348142] 'agreement among raft nodes before linearized reading'  (duration: 155.981919ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:18.271478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.460151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107308"}
{"level":"info","ts":"2026-08-24T21:32:18.27157Z","caller":"traceutil/trace.go:171","msg":"trace[837491936] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:29733; }","duration":"136.616364ms","start":"2026-08-24T21:32:18.134928Z","end":"2026-08-24T21:32:18.271544Z","steps":["trace[837491936] 'agreement among raft nodes before linearized reading'  (duration: 136.288857ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:18.477647Z","caller":"traceutil/trace.go:171","msg":"trace[1010308540] transaction","detail":"{read_only:false; response_revision:29734; number_of_response:1; }","duration":"200.330796ms","start":"2026-08-24T21:32:18.27726Z","end":"2026-08-24T21:32:18.477591Z","steps":["trace[1010308540] 'process raft request'  (duration: 125.111194ms)","trace[1010308540] 'compare'  (duration: 74.848014ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:18.477709Z","caller":"traceutil/trace.go:171","msg":"trace[1214314677] transaction","detail":"{read_only:false; response_revision:29735; number_of_response:1; }","duration":"200.418749ms","start":"2026-08-24T21:32:18.27726Z","end":"2026-08-24T21:32:18.477678Z","steps":["trace[1214314677] 'process raft request'  (duration: 200.163592ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:18.477783Z","caller":"traceutil/trace.go:171","msg":"trace[1477642162] linearizableReadLoop","detail":"{readStateIndex:31095; appliedIndex:31093; }","duration":"200.333107ms","start":"2026-08-24T21:32:18.277414Z","end":"2026-08-24T21:32:18.477747Z","steps":["trace[1477642162] 'read index received'  (duration: 125.018202ms)","trace[1477642162] 'applied index is now lower than readState.Index'  (duration: 75.312415ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:18.478031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.589753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-24T21:32:18.478045Z","caller":"traceutil/trace.go:171","msg":"trace[568640729] transaction","detail":"{read_only:false; response_revision:29736; number_of_response:1; }","duration":"200.484171ms","start":"2026-08-24T21:32:18.277546Z","end":"2026-08-24T21:32:18.47803Z","steps":["trace[568640729] 'process raft request'  (duration: 199.952338ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:18.478095Z","caller":"traceutil/trace.go:171","msg":"trace[841852610] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:29735; }","duration":"200.689795ms","start":"2026-08-24T21:32:18.277391Z","end":"2026-08-24T21:32:18.478081Z","steps":["trace[841852610] 'agreement among raft nodes before linearized reading'  (duration: 200.48308ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:18.478172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.879088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:32:18.478221Z","caller":"traceutil/trace.go:171","msg":"trace[409689750] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:29737; }","duration":"175.95721ms","start":"2026-08-24T21:32:18.302247Z","end":"2026-08-24T21:32:18.478204Z","steps":["trace[409689750] 'agreement among raft nodes before linearized reading'  (duration: 175.844298ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:18.478422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.137183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-node-lease/\" range_end:\"/registry/secrets/kube-node-lease0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:32:18.478471Z","caller":"traceutil/trace.go:171","msg":"trace[2025690449] range","detail":"{range_begin:/registry/secrets/kube-node-lease/; range_end:/registry/secrets/kube-node-lease0; response_count:0; response_revision:29737; }","duration":"107.224365ms","start":"2026-08-24T21:32:18.371233Z","end":"2026-08-24T21:32:18.478458Z","steps":["trace[2025690449] 'agreement among raft nodes before linearized reading'  (duration: 107.149024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:18.478472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.650321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-08-24T21:32:18.478514Z","caller":"traceutil/trace.go:171","msg":"trace[1028120612] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:29737; }","duration":"155.762964ms","start":"2026-08-24T21:32:18.322736Z","end":"2026-08-24T21:32:18.478499Z","steps":["trace[1028120612] 'agreement among raft nodes before linearized reading'  (duration: 155.659802ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:18.709702Z","caller":"traceutil/trace.go:171","msg":"trace[754959419] linearizableReadLoop","detail":"{readStateIndex:31098; appliedIndex:31097; }","duration":"177.645661ms","start":"2026-08-24T21:32:18.532024Z","end":"2026-08-24T21:32:18.709669Z","steps":["trace[754959419] 'read index received'  (duration: 164.55101ms)","trace[754959419] 'applied index is now lower than readState.Index'  (duration: 13.092721ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:18.709874Z","caller":"traceutil/trace.go:171","msg":"trace[1697047522] transaction","detail":"{read_only:false; response_revision:29738; number_of_response:1; }","duration":"221.070675ms","start":"2026-08-24T21:32:18.488782Z","end":"2026-08-24T21:32:18.709853Z","steps":["trace[1697047522] 'process raft request'  (duration: 207.927823ms)","trace[1697047522] 'compare'  (duration: 12.765893ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:18.710041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.996809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-public/\" range_end:\"/registry/secrets/kube-public0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-24T21:32:18.710341Z","caller":"traceutil/trace.go:171","msg":"trace[1032400392] range","detail":"{range_begin:/registry/secrets/kube-public/; range_end:/registry/secrets/kube-public0; response_count:0; response_revision:29738; }","duration":"178.359169ms","start":"2026-08-24T21:32:18.531951Z","end":"2026-08-24T21:32:18.71031Z","steps":["trace[1032400392] 'agreement among raft nodes before linearized reading'  (duration: 177.99902ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:19.16697Z","caller":"traceutil/trace.go:171","msg":"trace[1119516188] transaction","detail":"{read_only:false; response_revision:29741; number_of_response:1; }","duration":"132.462124ms","start":"2026-08-24T21:32:19.034482Z","end":"2026-08-24T21:32:19.166944Z","steps":["trace[1119516188] 'process raft request'  (duration: 59.566329ms)","trace[1119516188] 'compare'  (duration: 71.256125ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:19.454915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.170003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12752"}
{"level":"info","ts":"2026-08-24T21:32:19.455037Z","caller":"traceutil/trace.go:171","msg":"trace[1102438536] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:29742; }","duration":"129.336357ms","start":"2026-08-24T21:32:19.32567Z","end":"2026-08-24T21:32:19.455006Z","steps":["trace[1102438536] 'range keys from in-memory index tree'  (duration: 128.949379ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:23.355568Z","caller":"traceutil/trace.go:171","msg":"trace[398446096] linearizableReadLoop","detail":"{readStateIndex:31136; appliedIndex:31135; }","duration":"109.199404ms","start":"2026-08-24T21:32:23.246331Z","end":"2026-08-24T21:32:23.355531Z","steps":["trace[398446096] 'read index received'  (duration: 66.613101ms)","trace[398446096] 'applied index is now lower than readState.Index'  (duration: 42.584773ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:23.355689Z","caller":"traceutil/trace.go:171","msg":"trace[1686079427] transaction","detail":"{read_only:false; response_revision:29775; number_of_response:1; }","duration":"141.810352ms","start":"2026-08-24T21:32:23.213798Z","end":"2026-08-24T21:32:23.355608Z","steps":["trace[1686079427] 'process raft request'  (duration: 99.166718ms)","trace[1686079427] 'compare'  (duration: 42.249495ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:23.357658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.302877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:184 size:1654822"}
{"level":"info","ts":"2026-08-24T21:32:23.357831Z","caller":"traceutil/trace.go:171","msg":"trace[119989152] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:184; response_revision:29775; }","duration":"111.526392ms","start":"2026-08-24T21:32:23.246275Z","end":"2026-08-24T21:32:23.357802Z","steps":["trace[119989152] 'agreement among raft nodes before linearized reading'  (duration: 109.379659ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:23.670447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.037038ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521228423438385359 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:29760 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:460 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-24T21:32:23.670714Z","caller":"traceutil/trace.go:171","msg":"trace[1500988379] transaction","detail":"{read_only:false; response_revision:29776; number_of_response:1; }","duration":"305.364859ms","start":"2026-08-24T21:32:23.365307Z","end":"2026-08-24T21:32:23.670672Z","steps":["trace[1500988379] 'process raft request'  (duration: 139.004874ms)","trace[1500988379] 'compare'  (duration: 165.700718ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:32:23.670811Z","caller":"traceutil/trace.go:171","msg":"trace[656587013] linearizableReadLoop","detail":"{readStateIndex:31137; appliedIndex:31136; }","duration":"232.675829ms","start":"2026-08-24T21:32:23.438083Z","end":"2026-08-24T21:32:23.670759Z","steps":["trace[656587013] 'read index received'  (duration: 66.250762ms)","trace[656587013] 'applied index is now lower than readState.Index'  (duration: 166.416497ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-24T21:32:23.67093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T21:32:23.365279Z","time spent":"305.524912ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":536,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:29760 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:460 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-24T21:32:23.704912Z","caller":"traceutil/trace.go:171","msg":"trace[117348579] transaction","detail":"{read_only:false; response_revision:29777; number_of_response:1; }","duration":"210.683109ms","start":"2026-08-24T21:32:23.494203Z","end":"2026-08-24T21:32:23.704886Z","steps":["trace[117348579] 'process raft request'  (duration: 209.87312ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:23.705116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.672499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-24T21:32:23.705165Z","caller":"traceutil/trace.go:171","msg":"trace[94014002] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:29779; }","duration":"190.775922ms","start":"2026-08-24T21:32:23.514374Z","end":"2026-08-24T21:32:23.70515Z","steps":["trace[94014002] 'agreement among raft nodes before linearized reading'  (duration: 190.664089ms)"],"step_count":1}
{"level":"info","ts":"2026-08-24T21:32:23.704954Z","caller":"traceutil/trace.go:171","msg":"trace[1355251737] transaction","detail":"{read_only:false; response_revision:29778; number_of_response:1; }","duration":"129.696436ms","start":"2026-08-24T21:32:23.575223Z","end":"2026-08-24T21:32:23.704919Z","steps":["trace[1355251737] 'process raft request'  (duration: 129.489851ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-24T21:32:23.706222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.117815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:184 size:1654822"}
{"level":"info","ts":"2026-08-24T21:32:23.70641Z","caller":"traceutil/trace.go:171","msg":"trace[38268639] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:184; response_revision:29776; }","duration":"268.369571ms","start":"2026-08-24T21:32:23.438005Z","end":"2026-08-24T21:32:23.706375Z","steps":["trace[38268639] 'agreement among raft nodes before linearized reading'  (duration: 232.947415ms)","trace[38268639] 'range keys from in-memory index tree'  (duration: 33.367517ms)"],"step_count":2}
{"level":"info","ts":"2026-08-24T21:33:04.584693Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26928}
{"level":"info","ts":"2026-08-24T21:33:04.746339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26928,"took":"157.322453ms","hash":3238424964,"current-db-size-bytes":61865984,"current-db-size":"62 MB","current-db-size-in-use-bytes":34676736,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-24T21:33:04.74642Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3238424964,"revision":26928,"compact-revision":23479}