{"level":"warn","ts":"2026-05-09T16:54:59.821769Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T16:54:59.821897Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-09T16:54:59.821993Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T16:54:59.822008Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]}
{"level":"info","ts":"2026-05-09T16:54:59.82203Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-09T16:54:59.82264Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]}
{"level":"info","ts":"2026-05-09T16:54:59.82272Z","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.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-09T16:54:59.827282Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.300787ms"}
{"level":"info","ts":"2026-05-09T16:54:59.841248Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"}
{"level":"info","ts":"2026-05-09T16:54:59.84135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-09T16:54:59.841371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"}
{"level":"info","ts":"2026-05-09T16:54:59.841401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-09T16:54:59.841411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"}
{"level":"info","ts":"2026-05-09T16:54:59.841455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"}
{"level":"warn","ts":"2026-05-09T16:54:59.859789Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-09T16:54:59.86299Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-09T16:54:59.864641Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-09T16:54:59.867442Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-09T16:54:59.867652Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-09T16:54:59.867841Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T16:54:59.867989Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T16:54:59.868016Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T16:54:59.869086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"}
{"level":"info","ts":"2026-05-09T16:54:59.869291Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]}
{"level":"info","ts":"2026-05-09T16:54:59.871021Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-09T16:54:59.871261Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"}
{"level":"info","ts":"2026-05-09T16:54:59.871281Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-09T16:54:59.871332Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"}
{"level":"info","ts":"2026-05-09T16:54:59.871358Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-09T16:55:00.041655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-09T16:55:00.041828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-09T16:55:00.04187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"}
{"level":"info","ts":"2026-05-09T16:55:00.041896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"}
{"level":"info","ts":"2026-05-09T16:55:00.041915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"}
{"level":"info","ts":"2026-05-09T16:55:00.041942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"}
{"level":"info","ts":"2026-05-09T16:55:00.041965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"}
{"level":"info","ts":"2026-05-09T16:55:00.043935Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:55:00.045349Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-09T16:55:00.045393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T16:55:00.045355Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T16:55:00.045682Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-09T16:55:00.045749Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-09T16:55:00.04706Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:55:00.047305Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:55:00.047351Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:55:00.048203Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"}
{"level":"info","ts":"2026-05-09T16:55:00.049549Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-09T16:55:31.53931Z","caller":"traceutil/trace.go:171","msg":"trace[1309218444] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"106.557307ms","start":"2026-05-09T16:55:31.432722Z","end":"2026-05-09T16:55:31.539279Z","steps":["trace[1309218444] 'process raft request'  (duration: 106.276159ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:31.539467Z","caller":"traceutil/trace.go:171","msg":"trace[56725782] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"106.489865ms","start":"2026-05-09T16:55:31.432927Z","end":"2026-05-09T16:55:31.539417Z","steps":["trace[56725782] 'process raft request'  (duration: 106.244849ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:31.539642Z","caller":"traceutil/trace.go:171","msg":"trace[1727466477] transaction","detail":"{read_only:false; number_of_response:1; response_revision:529; }","duration":"105.57448ms","start":"2026-05-09T16:55:31.434053Z","end":"2026-05-09T16:55:31.539628Z","steps":["trace[1727466477] 'process raft request'  (duration: 105.365793ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:31.539768Z","caller":"traceutil/trace.go:171","msg":"trace[928778597] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"106.68684ms","start":"2026-05-09T16:55:31.433068Z","end":"2026-05-09T16:55:31.539755Z","steps":["trace[928778597] 'process raft request'  (duration: 106.286339ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:31.539922Z","caller":"traceutil/trace.go:171","msg":"trace[533700204] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"105.647052ms","start":"2026-05-09T16:55:31.434261Z","end":"2026-05-09T16:55:31.539908Z","steps":["trace[533700204] 'process raft request'  (duration: 105.2035ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:37.638149Z","caller":"traceutil/trace.go:171","msg":"trace[683223764] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"248.050221ms","start":"2026-05-09T16:55:37.39007Z","end":"2026-05-09T16:55:37.63812Z","steps":["trace[683223764] 'process raft request'  (duration: 247.868185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:37.826054Z","caller":"traceutil/trace.go:171","msg":"trace[260218032] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"263.556884ms","start":"2026-05-09T16:55:37.562451Z","end":"2026-05-09T16:55:37.826008Z","steps":["trace[260218032] 'read index received'  (duration: 75.575005ms)","trace[260218032] 'applied index is now lower than readState.Index'  (duration: 187.979989ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:37.826146Z","caller":"traceutil/trace.go:171","msg":"trace[1734831492] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"280.416085ms","start":"2026-05-09T16:55:37.545696Z","end":"2026-05-09T16:55:37.826112Z","steps":["trace[1734831492] 'process raft request'  (duration: 274.382829ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:37.826362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.864572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T16:55:37.826654Z","caller":"traceutil/trace.go:171","msg":"trace[1859814931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"264.252083ms","start":"2026-05-09T16:55:37.562389Z","end":"2026-05-09T16:55:37.826641Z","steps":["trace[1859814931] 'agreement among raft nodes before linearized reading'  (duration: 263.76543ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:38.209831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.928103ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882705966 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:610 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:55:38.209962Z","caller":"traceutil/trace.go:171","msg":"trace[1736887088] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"289.711239ms","start":"2026-05-09T16:55:37.92023Z","end":"2026-05-09T16:55:38.209942Z","steps":["trace[1736887088] 'process raft request'  (duration: 95.978353ms)","trace[1736887088] 'compare'  (duration: 192.78716ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:38.286117Z","caller":"traceutil/trace.go:171","msg":"trace[1505809581] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"364.255546ms","start":"2026-05-09T16:55:37.921828Z","end":"2026-05-09T16:55:38.286084Z","steps":["trace[1505809581] 'process raft request'  (duration: 364.02808ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:38.286294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:37.921813Z","time spent":"364.37788ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:611 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-09T16:57:07.472276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.655908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad83a3c5-77cc-4202-adb0-01b62a4d0d7b\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-09T16:57:07.47237Z","caller":"traceutil/trace.go:171","msg":"trace[1184516914] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad83a3c5-77cc-4202-adb0-01b62a4d0d7b; range_end:; response_count:1; response_revision:1845; }","duration":"179.832692ms","start":"2026-05-09T16:57:07.292517Z","end":"2026-05-09T16:57:07.47235Z","steps":["trace[1184516914] 'range keys from in-memory index tree'  (duration: 179.429921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:08.004921Z","caller":"traceutil/trace.go:171","msg":"trace[1538635504] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"143.479448ms","start":"2026-05-09T16:57:07.861402Z","end":"2026-05-09T16:57:08.004882Z","steps":["trace[1538635504] 'process raft request'  (duration: 142.704008ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:08.004977Z","caller":"traceutil/trace.go:171","msg":"trace[1032161725] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1915; }","duration":"138.545163ms","start":"2026-05-09T16:57:07.866409Z","end":"2026-05-09T16:57:08.004954Z","steps":["trace[1032161725] 'read index received'  (duration: 137.708991ms)","trace[1032161725] 'applied index is now lower than readState.Index'  (duration: 835.052µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:57:08.005333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.908685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:57:08.005383Z","caller":"traceutil/trace.go:171","msg":"trace[886108414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1847; }","duration":"139.016188ms","start":"2026-05-09T16:57:07.866356Z","end":"2026-05-09T16:57:08.005372Z","steps":["trace[886108414] 'agreement among raft nodes before linearized reading'  (duration: 138.737619ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:57:08.0054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.891836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad83a3c5-77cc-4202-adb0-01b62a4d0d7b\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-09T16:57:08.005447Z","caller":"traceutil/trace.go:171","msg":"trace[1980473577] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad83a3c5-77cc-4202-adb0-01b62a4d0d7b; range_end:; response_count:1; response_revision:1848; }","duration":"130.949637ms","start":"2026-05-09T16:57:07.87448Z","end":"2026-05-09T16:57:08.00543Z","steps":["trace[1980473577] 'agreement among raft nodes before linearized reading'  (duration: 130.711971ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:57:58.664381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.266726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:57:58.664512Z","caller":"traceutil/trace.go:171","msg":"trace[484079944] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:2170; }","duration":"103.482232ms","start":"2026-05-09T16:57:58.561005Z","end":"2026-05-09T16:57:58.664487Z","steps":["trace[484079944] 'count revisions from in-memory index tree'  (duration: 103.160392ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:57:58.664409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.793613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-09T16:57:58.664739Z","caller":"traceutil/trace.go:171","msg":"trace[861738314] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2170; }","duration":"132.166813ms","start":"2026-05-09T16:57:58.532524Z","end":"2026-05-09T16:57:58.664691Z","steps":["trace[861738314] 'range keys from in-memory index tree'  (duration: 131.538127ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:59:21.058923Z","caller":"traceutil/trace.go:171","msg":"trace[1722800572] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"126.327511ms","start":"2026-05-09T16:59:20.932566Z","end":"2026-05-09T16:59:21.058894Z","steps":["trace[1722800572] 'process raft request'  (duration: 126.172917ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:59:21.306384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.564951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T16:59:21.306457Z","caller":"traceutil/trace.go:171","msg":"trace[1938976500] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2812; }","duration":"172.700374ms","start":"2026-05-09T16:59:21.13374Z","end":"2026-05-09T16:59:21.306441Z","steps":["trace[1938976500] 'range keys from in-memory index tree'  (duration: 172.430276ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:59:21.30669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.979698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-05-09T16:59:21.30672Z","caller":"traceutil/trace.go:171","msg":"trace[739731088] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2812; }","duration":"171.026668ms","start":"2026-05-09T16:59:21.135684Z","end":"2026-05-09T16:59:21.306711Z","steps":["trace[739731088] 'range keys from in-memory index tree'  (duration: 170.872294ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:59:21.306761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.666685ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882710684 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2805 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:59:21.307057Z","caller":"traceutil/trace.go:171","msg":"trace[766945932] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"144.767713ms","start":"2026-05-09T16:59:21.162277Z","end":"2026-05-09T16:59:21.307045Z","steps":["trace[766945932] 'process raft request'  (duration: 33.710708ms)","trace[766945932] 'compare'  (duration: 110.247033ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:03:25.165252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.601129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"}
{"level":"warn","ts":"2026-05-09T17:03:25.165266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.211099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-061e6e44-2703-42c8-9f54-be8ab28e29f4\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-09T17:03:25.165358Z","caller":"traceutil/trace.go:171","msg":"trace[217581863] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5013; }","duration":"197.808655ms","start":"2026-05-09T17:03:24.967527Z","end":"2026-05-09T17:03:25.165335Z","steps":["trace[217581863] 'range keys from in-memory index tree'  (duration: 197.386843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:25.165414Z","caller":"traceutil/trace.go:171","msg":"trace[1518271282] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-061e6e44-2703-42c8-9f54-be8ab28e29f4; range_end:; response_count:1; response_revision:5013; }","duration":"193.452586ms","start":"2026-05-09T17:03:24.971931Z","end":"2026-05-09T17:03:25.165384Z","steps":["trace[1518271282] 'range keys from in-memory index tree'  (duration: 192.803688ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:25.172102Z","caller":"traceutil/trace.go:171","msg":"trace[1344332858] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"115.750834ms","start":"2026-05-09T17:03:25.056322Z","end":"2026-05-09T17:03:25.172073Z","steps":["trace[1344332858] 'process raft request'  (duration: 115.546349ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:33.185271Z","caller":"traceutil/trace.go:171","msg":"trace[223271724] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"100.504ms","start":"2026-05-09T17:03:33.084734Z","end":"2026-05-09T17:03:33.185238Z","steps":["trace[223271724] 'process raft request'  (duration: 100.285864ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:33.370992Z","caller":"traceutil/trace.go:171","msg":"trace[1789885919] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"102.288429ms","start":"2026-05-09T17:03:33.268668Z","end":"2026-05-09T17:03:33.370957Z","steps":["trace[1789885919] 'process raft request'  (duration: 99.363649ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:33.371521Z","caller":"traceutil/trace.go:171","msg":"trace[1311759811] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"102.518805ms","start":"2026-05-09T17:03:33.268969Z","end":"2026-05-09T17:03:33.371488Z","steps":["trace[1311759811] 'process raft request'  (duration: 102.167875ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:33.371786Z","caller":"traceutil/trace.go:171","msg":"trace[1629924965] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"102.074863ms","start":"2026-05-09T17:03:33.269673Z","end":"2026-05-09T17:03:33.371748Z","steps":["trace[1629924965] 'process raft request'  (duration: 101.763494ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:36.973501Z","caller":"traceutil/trace.go:171","msg":"trace[1093778182] linearizableReadLoop","detail":"{readStateIndex:5452; appliedIndex:5451; }","duration":"132.763686ms","start":"2026-05-09T17:03:36.840706Z","end":"2026-05-09T17:03:36.973469Z","steps":["trace[1093778182] 'read index received'  (duration: 132.309274ms)","trace[1093778182] 'applied index is now lower than readState.Index'  (duration: 451.912µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:03:36.97351Z","caller":"traceutil/trace.go:171","msg":"trace[1483064558] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"190.706701ms","start":"2026-05-09T17:03:36.782745Z","end":"2026-05-09T17:03:36.973452Z","steps":["trace[1483064558] 'process raft request'  (duration: 190.31435ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:03:36.9737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.952387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T17:03:36.973759Z","caller":"traceutil/trace.go:171","msg":"trace[1577877096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5260; }","duration":"110.06822ms","start":"2026-05-09T17:03:36.86368Z","end":"2026-05-09T17:03:36.973749Z","steps":["trace[1577877096] 'agreement among raft nodes before linearized reading'  (duration: 109.942866ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:03:36.973755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.033654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jnmh5\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-05-09T17:03:36.973882Z","caller":"traceutil/trace.go:171","msg":"trace[1918034231] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jnmh5; range_end:; response_count:1; response_revision:5260; }","duration":"133.215269ms","start":"2026-05-09T17:03:36.840647Z","end":"2026-05-09T17:03:36.973863Z","steps":["trace[1918034231] 'agreement among raft nodes before linearized reading'  (duration: 132.924541ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:45.225705Z","caller":"traceutil/trace.go:171","msg":"trace[1403260936] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"162.304049ms","start":"2026-05-09T17:03:45.063365Z","end":"2026-05-09T17:03:45.225669Z","steps":["trace[1403260936] 'process raft request'  (duration: 93.034397ms)","trace[1403260936] 'compare'  (duration: 69.032036ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:03:45.225896Z","caller":"traceutil/trace.go:171","msg":"trace[2086843598] linearizableReadLoop","detail":"{readStateIndex:5624; appliedIndex:5621; }","duration":"158.384024ms","start":"2026-05-09T17:03:45.067489Z","end":"2026-05-09T17:03:45.225873Z","steps":["trace[2086843598] 'read index received'  (duration: 39.35482ms)","trace[2086843598] 'applied index is now lower than readState.Index'  (duration: 119.028234ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:03:45.226198Z","caller":"traceutil/trace.go:171","msg":"trace[1521636671] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"162.711921ms","start":"2026-05-09T17:03:45.063455Z","end":"2026-05-09T17:03:45.226167Z","steps":["trace[1521636671] 'process raft request'  (duration: 162.161826ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:03:45.226298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.788594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80103"}
{"level":"info","ts":"2026-05-09T17:03:45.226361Z","caller":"traceutil/trace.go:171","msg":"trace[1164183708] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5430; }","duration":"158.865456ms","start":"2026-05-09T17:03:45.067479Z","end":"2026-05-09T17:03:45.226345Z","steps":["trace[1164183708] 'agreement among raft nodes before linearized reading'  (duration: 158.562078ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:03:45.433296Z","caller":"traceutil/trace.go:171","msg":"trace[1040577738] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"197.99806ms","start":"2026-05-09T17:03:45.23526Z","end":"2026-05-09T17:03:45.433258Z","steps":["trace[1040577738] 'process raft request'  (duration: 176.206558ms)","trace[1040577738] 'compare'  (duration: 21.515385ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:03:56.478822Z","caller":"traceutil/trace.go:171","msg":"trace[466223654] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"101.115637ms","start":"2026-05-09T17:03:56.377664Z","end":"2026-05-09T17:03:56.47878Z","steps":["trace[466223654] 'process raft request'  (duration: 100.886291ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:04:34.733942Z","caller":"traceutil/trace.go:171","msg":"trace[288995651] transaction","detail":"{read_only:false; response_revision:5924; number_of_response:1; }","duration":"108.77346ms","start":"2026-05-09T17:04:34.625134Z","end":"2026-05-09T17:04:34.733908Z","steps":["trace[288995651] 'process raft request'  (duration: 108.562224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:05:00.218862Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3026}
{"level":"info","ts":"2026-05-09T17:05:00.302316Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3026,"took":"81.379607ms","hash":4111713188,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":31678464,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T17:05:00.302404Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4111713188,"revision":3026,"compact-revision":-1}
{"level":"info","ts":"2026-05-09T17:09:39.169394Z","caller":"traceutil/trace.go:171","msg":"trace[48492887] linearizableReadLoop","detail":"{readStateIndex:8477; appliedIndex:8476; }","duration":"304.946135ms","start":"2026-05-09T17:09:38.864416Z","end":"2026-05-09T17:09:39.169362Z","steps":["trace[48492887] 'read index received'  (duration: 303.002322ms)","trace[48492887] 'applied index is now lower than readState.Index'  (duration: 1.942623ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:09:39.169447Z","caller":"traceutil/trace.go:171","msg":"trace[770212918] transaction","detail":"{read_only:false; response_revision:8195; number_of_response:1; }","duration":"307.799804ms","start":"2026-05-09T17:09:38.861603Z","end":"2026-05-09T17:09:39.169403Z","steps":["trace[770212918] 'process raft request'  (duration: 305.83367ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:39.169506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.0831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T17:09:39.169577Z","caller":"traceutil/trace.go:171","msg":"trace[1177255138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8195; }","duration":"305.200623ms","start":"2026-05-09T17:09:38.864357Z","end":"2026-05-09T17:09:39.169557Z","steps":["trace[1177255138] 'agreement among raft nodes before linearized reading'  (duration: 305.09707ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:39.169616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:09:38.864329Z","time spent":"305.281445ms","remote":"127.0.0.1:57770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T17:09:39.169607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:09:38.861574Z","time spent":"307.946418ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8186 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T17:09:39.169803Z","caller":"traceutil/trace.go:171","msg":"trace[467338284] transaction","detail":"{read_only:false; response_revision:8196; number_of_response:1; }","duration":"290.476563ms","start":"2026-05-09T17:09:38.879268Z","end":"2026-05-09T17:09:39.169744Z","steps":["trace[467338284] 'process raft request'  (duration: 290.219846ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:39.169947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.722908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T17:09:39.169999Z","caller":"traceutil/trace.go:171","msg":"trace[962740362] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8196; }","duration":"158.837631ms","start":"2026-05-09T17:09:39.01115Z","end":"2026-05-09T17:09:39.169987Z","steps":["trace[962740362] 'agreement among raft nodes before linearized reading'  (duration: 158.640236ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:39.169981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.297864ms","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-05-09T17:09:39.170097Z","caller":"traceutil/trace.go:171","msg":"trace[238222320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8196; }","duration":"155.452569ms","start":"2026-05-09T17:09:39.01462Z","end":"2026-05-09T17:09:39.170073Z","steps":["trace[238222320] 'agreement among raft nodes before linearized reading'  (duration: 155.14543ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:09:39.170193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.864442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-09T17:09:39.170342Z","caller":"traceutil/trace.go:171","msg":"trace[1982481363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8196; }","duration":"259.021436ms","start":"2026-05-09T17:09:38.911264Z","end":"2026-05-09T17:09:39.170285Z","steps":["trace[1982481363] 'agreement among raft nodes before linearized reading'  (duration: 258.447251ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:10:00.225608Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6131}
{"level":"info","ts":"2026-05-09T17:10:00.323379Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6131,"took":"95.827017ms","hash":305903100,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":23126016,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-09T17:10:00.323442Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":305903100,"revision":6131,"compact-revision":3026}
{"level":"info","ts":"2026-05-09T17:10:19.528356Z","caller":"traceutil/trace.go:171","msg":"trace[1590392602] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"152.585931ms","start":"2026-05-09T17:10:19.375748Z","end":"2026-05-09T17:10:19.528334Z","steps":["trace[1590392602] 'process raft request'  (duration: 152.428596ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:10:31.25053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.351149ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882725569 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-65zjw\" mod_revision:8436 > success:<request_delete_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-65zjw\" > > failure:<request_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-65zjw\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:10:31.250693Z","caller":"traceutil/trace.go:171","msg":"trace[952519676] linearizableReadLoop","detail":"{readStateIndex:8866; appliedIndex:8864; }","duration":"239.692932ms","start":"2026-05-09T17:10:31.010987Z","end":"2026-05-09T17:10:31.25068Z","steps":["trace[952519676] 'read index received'  (duration: 210.837287ms)","trace[952519676] 'applied index is now lower than readState.Index'  (duration: 28.854605ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:10:31.250801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.820995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-05-09T17:10:31.250826Z","caller":"traceutil/trace.go:171","msg":"trace[217208514] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8567; }","duration":"239.879326ms","start":"2026-05-09T17:10:31.010938Z","end":"2026-05-09T17:10:31.250818Z","steps":["trace[217208514] 'agreement among raft nodes before linearized reading'  (duration: 239.777064ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:10:31.250861Z","caller":"traceutil/trace.go:171","msg":"trace[1196715408] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8566; }","duration":"266.018147ms","start":"2026-05-09T17:10:30.984811Z","end":"2026-05-09T17:10:31.25083Z","steps":["trace[1196715408] 'process raft request'  (duration: 25.246986ms)","trace[1196715408] 'compare'  (duration: 240.247757ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:10:31.250991Z","caller":"traceutil/trace.go:171","msg":"trace[1273693255] transaction","detail":"{read_only:false; response_revision:8567; number_of_response:1; }","duration":"264.109645ms","start":"2026-05-09T17:10:30.986872Z","end":"2026-05-09T17:10:31.250982Z","steps":["trace[1273693255] 'process raft request'  (duration: 263.757265ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:10:31.79972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.412319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228476"}
{"level":"info","ts":"2026-05-09T17:10:31.79981Z","caller":"traceutil/trace.go:171","msg":"trace[1743828989] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8574; }","duration":"126.551793ms","start":"2026-05-09T17:10:31.673241Z","end":"2026-05-09T17:10:31.799793Z","steps":["trace[1743828989] 'range keys from in-memory index tree'  (duration: 126.014718ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:10:32.102904Z","caller":"traceutil/trace.go:171","msg":"trace[1940343578] transaction","detail":"{read_only:false; response_revision:8576; number_of_response:1; }","duration":"200.528215ms","start":"2026-05-09T17:10:31.902337Z","end":"2026-05-09T17:10:32.102865Z","steps":["trace[1940343578] 'process raft request'  (duration: 154.690688ms)","trace[1940343578] 'compare'  (duration: 45.459877ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:11:27.401655Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024e3.wal"}
{"level":"info","ts":"2026-05-09T17:11:42.077821Z","caller":"traceutil/trace.go:171","msg":"trace[656132305] transaction","detail":"{read_only:false; response_revision:9222; number_of_response:1; }","duration":"231.997251ms","start":"2026-05-09T17:11:41.845795Z","end":"2026-05-09T17:11:42.077792Z","steps":["trace[656132305] 'process raft request'  (duration: 231.302543ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:11:42.144332Z","caller":"traceutil/trace.go:171","msg":"trace[337240836] linearizableReadLoop","detail":"{readStateIndex:9541; appliedIndex:9539; }","duration":"192.848807ms","start":"2026-05-09T17:11:41.951459Z","end":"2026-05-09T17:11:42.144308Z","steps":["trace[337240836] 'read index received'  (duration: 125.644439ms)","trace[337240836] 'applied index is now lower than readState.Index'  (duration: 67.203448ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:11:42.144742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.960869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-09T17:11:42.144744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.277768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-09T17:11:42.144786Z","caller":"traceutil/trace.go:171","msg":"trace[1740611904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9223; }","duration":"193.035942ms","start":"2026-05-09T17:11:41.951741Z","end":"2026-05-09T17:11:42.144777Z","steps":["trace[1740611904] 'agreement among raft nodes before linearized reading'  (duration: 192.919729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:11:42.144799Z","caller":"traceutil/trace.go:171","msg":"trace[1053220914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9223; }","duration":"193.920865ms","start":"2026-05-09T17:11:41.950864Z","end":"2026-05-09T17:11:42.144785Z","steps":["trace[1053220914] 'agreement among raft nodes before linearized reading'  (duration: 193.74726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:11:42.144789Z","caller":"traceutil/trace.go:171","msg":"trace[744585922] transaction","detail":"{read_only:false; response_revision:9223; number_of_response:1; }","duration":"283.470602ms","start":"2026-05-09T17:11:41.861298Z","end":"2026-05-09T17:11:42.144768Z","steps":["trace[744585922] 'process raft request'  (duration: 254.74267ms)","trace[744585922] 'compare'  (duration: 28.142366ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:11:42.144954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.442138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T17:11:42.145015Z","caller":"traceutil/trace.go:171","msg":"trace[603458509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9223; }","duration":"191.535781ms","start":"2026-05-09T17:11:41.953463Z","end":"2026-05-09T17:11:42.144999Z","steps":["trace[603458509] 'agreement among raft nodes before linearized reading'  (duration: 191.284594ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:12:30.141625Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T17:12:30.147388Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-09T17:12:30.147464Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-09T17:14:09.161886Z","caller":"traceutil/trace.go:171","msg":"trace[97142329] linearizableReadLoop","detail":"{readStateIndex:10777; appliedIndex:10775; }","duration":"137.822217ms","start":"2026-05-09T17:14:09.02404Z","end":"2026-05-09T17:14:09.161862Z","steps":["trace[97142329] 'read index received'  (duration: 2.647322ms)","trace[97142329] 'applied index is now lower than readState.Index'  (duration: 135.173815ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:14:09.161977Z","caller":"traceutil/trace.go:171","msg":"trace[389872187] transaction","detail":"{read_only:false; response_revision:10420; number_of_response:1; }","duration":"141.020384ms","start":"2026-05-09T17:14:09.020925Z","end":"2026-05-09T17:14:09.161945Z","steps":["trace[389872187] 'process raft request'  (duration: 140.791258ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:14:09.16209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.037353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-09T17:14:09.162124Z","caller":"traceutil/trace.go:171","msg":"trace[275376054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10420; }","duration":"138.127455ms","start":"2026-05-09T17:14:09.023988Z","end":"2026-05-09T17:14:09.162115Z","steps":["trace[275376054] 'agreement among raft nodes before linearized reading'  (duration: 137.970571ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:14:09.179031Z","caller":"traceutil/trace.go:171","msg":"trace[1553516874] transaction","detail":"{read_only:false; response_revision:10421; number_of_response:1; }","duration":"128.155747ms","start":"2026-05-09T17:14:09.050856Z","end":"2026-05-09T17:14:09.179012Z","steps":["trace[1553516874] 'process raft request'  (duration: 128.017233ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:14:09.296811Z","caller":"traceutil/trace.go:171","msg":"trace[147346250] transaction","detail":"{read_only:false; response_revision:10423; number_of_response:1; }","duration":"103.511272ms","start":"2026-05-09T17:14:09.193264Z","end":"2026-05-09T17:14:09.296775Z","steps":["trace[147346250] 'process raft request'  (duration: 103.307697ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:15:00.231576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8314}
{"level":"info","ts":"2026-05-09T17:15:00.310666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8314,"took":"76.76773ms","hash":2888320905,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":26607616,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-09T17:15:00.310744Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2888320905,"revision":8314,"compact-revision":6131}
{"level":"info","ts":"2026-05-09T17:15:23.701729Z","caller":"traceutil/trace.go:171","msg":"trace[695391520] linearizableReadLoop","detail":"{readStateIndex:11535; appliedIndex:11533; }","duration":"159.824581ms","start":"2026-05-09T17:15:23.541882Z","end":"2026-05-09T17:15:23.701707Z","steps":["trace[695391520] 'read index received'  (duration: 144.21358ms)","trace[695391520] 'applied index is now lower than readState.Index'  (duration: 15.609921ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:15:23.701996Z","caller":"traceutil/trace.go:171","msg":"trace[334402560] transaction","detail":"{read_only:false; response_revision:11159; number_of_response:1; }","duration":"261.684008ms","start":"2026-05-09T17:15:23.440301Z","end":"2026-05-09T17:15:23.701985Z","steps":["trace[334402560] 'process raft request'  (duration: 245.820741ms)","trace[334402560] 'compare'  (duration: 15.401615ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:15:23.702311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.299688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-05-09T17:15:23.702386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.481928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-09T17:15:23.702407Z","caller":"traceutil/trace.go:171","msg":"trace[12485233] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11159; }","duration":"129.466552ms","start":"2026-05-09T17:15:23.572921Z","end":"2026-05-09T17:15:23.702388Z","steps":["trace[12485233] 'agreement among raft nodes before linearized reading'  (duration: 129.104702ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:15:23.702463Z","caller":"traceutil/trace.go:171","msg":"trace[1089599014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11159; }","duration":"160.589701ms","start":"2026-05-09T17:15:23.541854Z","end":"2026-05-09T17:15:23.702444Z","steps":["trace[1089599014] 'agreement among raft nodes before linearized reading'  (duration: 160.377406ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:15:23.856712Z","caller":"traceutil/trace.go:171","msg":"trace[188563048] transaction","detail":"{read_only:false; response_revision:11161; number_of_response:1; }","duration":"150.750415ms","start":"2026-05-09T17:15:23.705915Z","end":"2026-05-09T17:15:23.856666Z","steps":["trace[188563048] 'process raft request'  (duration: 150.55332ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:20:00.237573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10987}
{"level":"info","ts":"2026-05-09T17:20:00.317148Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10987,"took":"77.237873ms","hash":24950115,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":27860992,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-09T17:20:00.317225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":24950115,"revision":10987,"compact-revision":8314}
{"level":"info","ts":"2026-05-09T17:21:46.877163Z","caller":"traceutil/trace.go:171","msg":"trace[818823205] transaction","detail":"{read_only:false; response_revision:13741; number_of_response:1; }","duration":"185.614661ms","start":"2026-05-09T17:21:46.691515Z","end":"2026-05-09T17:21:46.87713Z","steps":["trace[818823205] 'process raft request'  (duration: 185.339784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:21:55.40143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.611662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/ovn-ovsdb-nb\" ","response":"range_response_count:1 size:520"}
{"level":"info","ts":"2026-05-09T17:21:55.401548Z","caller":"traceutil/trace.go:171","msg":"trace[1907318808] range","detail":"{range_begin:/registry/services/endpoints/openstack/ovn-ovsdb-nb; range_end:; response_count:1; response_revision:13897; }","duration":"116.794456ms","start":"2026-05-09T17:21:55.284726Z","end":"2026-05-09T17:21:55.401521Z","steps":["trace[1907318808] 'range keys from in-memory index tree'  (duration: 116.379915ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:21:55.401532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.709054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/ovn-ovsdb-sb\" ","response":"range_response_count:1 size:520"}
{"level":"info","ts":"2026-05-09T17:21:55.401634Z","caller":"traceutil/trace.go:171","msg":"trace[141425068] range","detail":"{range_begin:/registry/services/endpoints/openstack/ovn-ovsdb-sb; range_end:; response_count:1; response_revision:13897; }","duration":"116.898449ms","start":"2026-05-09T17:21:55.284709Z","end":"2026-05-09T17:21:55.401607Z","steps":["trace[141425068] 'range keys from in-memory index tree'  (duration: 116.443407ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:21:55.64957Z","caller":"traceutil/trace.go:171","msg":"trace[1032053512] transaction","detail":"{read_only:false; response_revision:13898; number_of_response:1; }","duration":"243.854951ms","start":"2026-05-09T17:21:55.405679Z","end":"2026-05-09T17:21:55.649534Z","steps":["trace[1032053512] 'process raft request'  (duration: 243.661776ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:21:55.678429Z","caller":"traceutil/trace.go:171","msg":"trace[1726047099] transaction","detail":"{read_only:false; response_revision:13899; number_of_response:1; }","duration":"272.020204ms","start":"2026-05-09T17:21:55.406362Z","end":"2026-05-09T17:21:55.678382Z","steps":["trace[1726047099] 'process raft request'  (duration: 271.763037ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:21:55.678645Z","caller":"traceutil/trace.go:171","msg":"trace[2021319206] transaction","detail":"{read_only:false; response_revision:13900; number_of_response:1; }","duration":"249.322319ms","start":"2026-05-09T17:21:55.429293Z","end":"2026-05-09T17:21:55.678615Z","steps":["trace[2021319206] 'process raft request'  (duration: 248.98161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:23:33.099881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.003717ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882743997 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:14968 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T17:23:33.100186Z","caller":"traceutil/trace.go:171","msg":"trace[1341377132] linearizableReadLoop","detail":"{readStateIndex:15482; appliedIndex:15480; }","duration":"190.491701ms","start":"2026-05-09T17:23:32.909674Z","end":"2026-05-09T17:23:33.100165Z","steps":["trace[1341377132] 'read index received'  (duration: 72.070413ms)","trace[1341377132] 'applied index is now lower than readState.Index'  (duration: 118.419588ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:23:33.100192Z","caller":"traceutil/trace.go:171","msg":"trace[1055487415] transaction","detail":"{read_only:false; response_revision:14979; number_of_response:1; }","duration":"226.428585ms","start":"2026-05-09T17:23:32.87373Z","end":"2026-05-09T17:23:33.100158Z","steps":["trace[1055487415] 'process raft request'  (duration: 108.003557ms)","trace[1055487415] 'compare'  (duration: 117.728649ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:23:33.100416Z","caller":"traceutil/trace.go:171","msg":"trace[566574694] transaction","detail":"{read_only:false; response_revision:14980; number_of_response:1; }","duration":"223.560527ms","start":"2026-05-09T17:23:32.876839Z","end":"2026-05-09T17:23:33.1004Z","steps":["trace[566574694] 'process raft request'  (duration: 223.201338ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:23:33.100655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.568078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T17:23:33.100732Z","caller":"traceutil/trace.go:171","msg":"trace[1578944693] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14980; }","duration":"130.697341ms","start":"2026-05-09T17:23:32.970012Z","end":"2026-05-09T17:23:33.100709Z","steps":["trace[1578944693] 'agreement among raft nodes before linearized reading'  (duration: 130.587938ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:23:33.10122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.542268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-09T17:23:33.101289Z","caller":"traceutil/trace.go:171","msg":"trace[1424433411] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:14980; }","duration":"191.646451ms","start":"2026-05-09T17:23:32.909624Z","end":"2026-05-09T17:23:33.10127Z","steps":["trace[1424433411] 'agreement among raft nodes before linearized reading'  (duration: 191.540239ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:23:33.101136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.084019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-05-09T17:23:33.101514Z","caller":"traceutil/trace.go:171","msg":"trace[142779598] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14980; }","duration":"128.49496ms","start":"2026-05-09T17:23:32.973006Z","end":"2026-05-09T17:23:33.101501Z","steps":["trace[142779598] 'agreement among raft nodes before linearized reading'  (duration: 127.937246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:23:33.101733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.644702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-09T17:23:33.101771Z","caller":"traceutil/trace.go:171","msg":"trace[44816822] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14980; }","duration":"129.720564ms","start":"2026-05-09T17:23:32.972042Z","end":"2026-05-09T17:23:33.101762Z","steps":["trace[44816822] 'agreement among raft nodes before linearized reading'  (duration: 129.612672ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:23:33.643349Z","caller":"traceutil/trace.go:171","msg":"trace[43376210] linearizableReadLoop","detail":"{readStateIndex:15485; appliedIndex:15483; }","duration":"139.036667ms","start":"2026-05-09T17:23:33.504282Z","end":"2026-05-09T17:23:33.643318Z","steps":["trace[43376210] 'read index received'  (duration: 33.998381ms)","trace[43376210] 'applied index is now lower than readState.Index'  (duration: 105.037196ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:23:33.643767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.462448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-09T17:23:33.643818Z","caller":"traceutil/trace.go:171","msg":"trace[912408792] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14982; }","duration":"139.574331ms","start":"2026-05-09T17:23:33.504229Z","end":"2026-05-09T17:23:33.643803Z","steps":["trace[912408792] 'agreement among raft nodes before linearized reading'  (duration: 139.200781ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:23:33.644222Z","caller":"traceutil/trace.go:171","msg":"trace[1953663666] transaction","detail":"{read_only:false; response_revision:14982; number_of_response:1; }","duration":"211.721005ms","start":"2026-05-09T17:23:33.432489Z","end":"2026-05-09T17:23:33.64421Z","steps":["trace[1953663666] 'process raft request'  (duration: 210.651406ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:23:33.715432Z","caller":"traceutil/trace.go:171","msg":"trace[2011424145] transaction","detail":"{read_only:false; response_revision:14983; number_of_response:1; }","duration":"151.67941ms","start":"2026-05-09T17:23:33.563734Z","end":"2026-05-09T17:23:33.715413Z","steps":["trace[2011424145] 'process raft request'  (duration: 143.311863ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:25:00.243156Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13041}
{"level":"info","ts":"2026-05-09T17:25:00.319188Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13041,"took":"73.012526ms","hash":3888192624,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":30879744,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T17:25:00.319239Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3888192624,"revision":13041,"compact-revision":10987}
{"level":"warn","ts":"2026-05-09T17:29:12.93269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.384523ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882753407 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-heat.18adf5d601c14f25\" mod_revision:17465 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-heat.18adf5d601c14f25\" value_size:646 lease:1613588348027976792 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-heat.18adf5d601c14f25\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:29:12.932842Z","caller":"traceutil/trace.go:171","msg":"trace[934011879] linearizableReadLoop","detail":"{readStateIndex:18124; appliedIndex:18123; }","duration":"169.441019ms","start":"2026-05-09T17:29:12.763379Z","end":"2026-05-09T17:29:12.93282Z","steps":["trace[934011879] 'read index received'  (duration: 18.750597ms)","trace[934011879] 'applied index is now lower than readState.Index'  (duration: 150.688471ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:29:12.932986Z","caller":"traceutil/trace.go:171","msg":"trace[1166773121] transaction","detail":"{read_only:false; response_revision:17539; number_of_response:1; }","duration":"170.753763ms","start":"2026-05-09T17:29:12.762196Z","end":"2026-05-09T17:29:12.93295Z","steps":["trace[1166773121] 'process raft request'  (duration: 19.969889ms)","trace[1166773121] 'compare'  (duration: 150.204709ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:29:12.933099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.701895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18826"}
{"level":"warn","ts":"2026-05-09T17:29:12.933124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.788114ms","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-05-09T17:29:12.933181Z","caller":"traceutil/trace.go:171","msg":"trace[921117917] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:17539; }","duration":"169.798748ms","start":"2026-05-09T17:29:12.763364Z","end":"2026-05-09T17:29:12.933163Z","steps":["trace[921117917] 'agreement among raft nodes before linearized reading'  (duration: 169.575692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:29:12.93321Z","caller":"traceutil/trace.go:171","msg":"trace[1774024456] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17539; }","duration":"133.922308ms","start":"2026-05-09T17:29:12.799266Z","end":"2026-05-09T17:29:12.933188Z","steps":["trace[1774024456] 'agreement among raft nodes before linearized reading'  (duration: 133.731403ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:29:12.933369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.837216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-7n65s\" ","response":"range_response_count:1 size:22126"}
{"level":"info","ts":"2026-05-09T17:29:12.933488Z","caller":"traceutil/trace.go:171","msg":"trace[1813178817] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-7n65s; range_end:; response_count:1; response_revision:17539; }","duration":"153.96959ms","start":"2026-05-09T17:29:12.779492Z","end":"2026-05-09T17:29:12.933461Z","steps":["trace[1813178817] 'agreement among raft nodes before linearized reading'  (duration: 153.488767ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:29:18.126768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.313077ms","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-05-09T17:29:18.126835Z","caller":"traceutil/trace.go:171","msg":"trace[1194936369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17571; }","duration":"175.418879ms","start":"2026-05-09T17:29:17.951401Z","end":"2026-05-09T17:29:18.12682Z","steps":["trace[1194936369] 'range keys from in-memory index tree'  (duration: 175.171453ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:29:18.363505Z","caller":"traceutil/trace.go:171","msg":"trace[1699049147] linearizableReadLoop","detail":"{readStateIndex:18158; appliedIndex:18157; }","duration":"223.092937ms","start":"2026-05-09T17:29:18.140388Z","end":"2026-05-09T17:29:18.363481Z","steps":["trace[1699049147] 'read index received'  (duration: 222.932713ms)","trace[1699049147] 'applied index is now lower than readState.Index'  (duration: 159.274µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:29:18.363798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.379424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zdtfj\" ","response":"range_response_count:1 size:20866"}
{"level":"info","ts":"2026-05-09T17:29:18.363895Z","caller":"traceutil/trace.go:171","msg":"trace[838699212] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zdtfj; range_end:; response_count:1; response_revision:17572; }","duration":"223.519408ms","start":"2026-05-09T17:29:18.140353Z","end":"2026-05-09T17:29:18.363873Z","steps":["trace[838699212] 'agreement among raft nodes before linearized reading'  (duration: 223.240901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:29:18.365606Z","caller":"traceutil/trace.go:171","msg":"trace[621593157] transaction","detail":"{read_only:false; response_revision:17572; number_of_response:1; }","duration":"233.144679ms","start":"2026-05-09T17:29:18.130403Z","end":"2026-05-09T17:29:18.363548Z","steps":["trace[621593157] 'process raft request'  (duration: 232.928873ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:30:00.248249Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15555}
{"level":"info","ts":"2026-05-09T17:30:00.354797Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15555,"took":"102.731066ms","hash":4116525805,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":33574912,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-09T17:30:00.354874Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4116525805,"revision":15555,"compact-revision":13041}
{"level":"info","ts":"2026-05-09T17:32:38.795619Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T17:32:38.800112Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-09T17:32:38.800206Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-05-09T17:33:51.9446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.307079ms","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-05-09T17:33:51.9447Z","caller":"traceutil/trace.go:171","msg":"trace[2005629439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19769; }","duration":"295.458303ms","start":"2026-05-09T17:33:51.649225Z","end":"2026-05-09T17:33:51.944684Z","steps":["trace[2005629439] 'range keys from in-memory index tree'  (duration: 295.110193ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:33:51.944816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.570384ms","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-05-09T17:33:51.944907Z","caller":"traceutil/trace.go:171","msg":"trace[1543657777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19769; }","duration":"134.704198ms","start":"2026-05-09T17:33:51.810181Z","end":"2026-05-09T17:33:51.944885Z","steps":["trace[1543657777] 'range keys from in-memory index tree'  (duration: 134.395979ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:33:52.102014Z","caller":"traceutil/trace.go:171","msg":"trace[258600294] transaction","detail":"{read_only:false; response_revision:19771; number_of_response:1; }","duration":"149.746206ms","start":"2026-05-09T17:33:51.952237Z","end":"2026-05-09T17:33:52.101983Z","steps":["trace[258600294] 'process raft request'  (duration: 149.591652ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:33:52.102209Z","caller":"traceutil/trace.go:171","msg":"trace[1269597104] transaction","detail":"{read_only:false; response_revision:19772; number_of_response:1; }","duration":"149.830359ms","start":"2026-05-09T17:33:51.95234Z","end":"2026-05-09T17:33:52.102171Z","steps":["trace[1269597104] 'process raft request'  (duration: 149.605033ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:33:53.231704Z","caller":"traceutil/trace.go:171","msg":"trace[499890125] transaction","detail":"{read_only:false; response_revision:19773; number_of_response:1; }","duration":"156.757656ms","start":"2026-05-09T17:33:53.074912Z","end":"2026-05-09T17:33:53.23167Z","steps":["trace[499890125] 'process raft request'  (duration: 156.53905ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:33:53.425132Z","caller":"traceutil/trace.go:171","msg":"trace[1031523017] transaction","detail":"{read_only:false; response_revision:19774; number_of_response:1; }","duration":"190.073031ms","start":"2026-05-09T17:33:53.235029Z","end":"2026-05-09T17:33:53.425102Z","steps":["trace[1031523017] 'process raft request'  (duration: 141.566705ms)","trace[1031523017] 'compare'  (duration: 48.371573ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:33:53.467048Z","caller":"traceutil/trace.go:171","msg":"trace[258554732] transaction","detail":"{read_only:false; response_revision:19775; number_of_response:1; }","duration":"231.25387ms","start":"2026-05-09T17:33:53.235775Z","end":"2026-05-09T17:33:53.467029Z","steps":["trace[258554732] 'process raft request'  (duration: 231.050554ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:33:53.467202Z","caller":"traceutil/trace.go:171","msg":"trace[278979] transaction","detail":"{read_only:false; response_revision:19776; number_of_response:1; }","duration":"118.349713ms","start":"2026-05-09T17:33:53.348841Z","end":"2026-05-09T17:33:53.467191Z","steps":["trace[278979] 'process raft request'  (duration: 118.078846ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:33:53.492585Z","caller":"traceutil/trace.go:171","msg":"trace[74490674] transaction","detail":"{read_only:false; response_revision:19777; number_of_response:1; }","duration":"105.287019ms","start":"2026-05-09T17:33:53.387268Z","end":"2026-05-09T17:33:53.492555Z","steps":["trace[74490674] 'process raft request'  (duration: 105.139735ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:35:00.256857Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18107}
{"level":"info","ts":"2026-05-09T17:35:00.374378Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18107,"took":"113.279786ms","hash":680531232,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":30547968,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T17:35:00.374459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":680531232,"revision":18107,"compact-revision":15555}
{"level":"info","ts":"2026-05-09T17:37:27.188042Z","caller":"traceutil/trace.go:171","msg":"trace[249512581] linearizableReadLoop","detail":"{readStateIndex:22818; appliedIndex:22817; }","duration":"157.340788ms","start":"2026-05-09T17:37:27.030678Z","end":"2026-05-09T17:37:27.188019Z","steps":["trace[249512581] 'read index received'  (duration: 157.112241ms)","trace[249512581] 'applied index is now lower than readState.Index'  (duration: 227.296µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:37:27.188093Z","caller":"traceutil/trace.go:171","msg":"trace[1075855949] transaction","detail":"{read_only:false; response_revision:22093; number_of_response:1; }","duration":"212.228089ms","start":"2026-05-09T17:37:26.975821Z","end":"2026-05-09T17:37:27.188049Z","steps":["trace[1075855949] 'process raft request'  (duration: 212.045364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:37:27.188286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.587554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-09T17:37:27.188382Z","caller":"traceutil/trace.go:171","msg":"trace[1040396547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22093; }","duration":"157.768069ms","start":"2026-05-09T17:37:27.030602Z","end":"2026-05-09T17:37:27.18837Z","steps":["trace[1040396547] 'agreement among raft nodes before linearized reading'  (duration: 157.557483ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:00.262418Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20417}
{"level":"info","ts":"2026-05-09T17:40:00.37895Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20417,"took":"112.956678ms","hash":3679587736,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":42496000,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-09T17:40:00.379034Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3679587736,"revision":20417,"compact-revision":18107}
{"level":"info","ts":"2026-05-09T17:40:48.083261Z","caller":"traceutil/trace.go:171","msg":"trace[1703165865] transaction","detail":"{read_only:false; response_revision:24160; number_of_response:1; }","duration":"112.813815ms","start":"2026-05-09T17:40:47.970415Z","end":"2026-05-09T17:40:48.083229Z","steps":["trace[1703165865] 'process raft request'  (duration: 112.548858ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:53.494321Z","caller":"traceutil/trace.go:171","msg":"trace[1743776173] transaction","detail":"{read_only:false; response_revision:24205; number_of_response:1; }","duration":"126.609181ms","start":"2026-05-09T17:40:53.367681Z","end":"2026-05-09T17:40:53.494291Z","steps":["trace[1743776173] 'process raft request'  (duration: 126.425855ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:53.817817Z","caller":"traceutil/trace.go:171","msg":"trace[1450210805] linearizableReadLoop","detail":"{readStateIndex:24987; appliedIndex:24985; }","duration":"304.796097ms","start":"2026-05-09T17:40:53.512981Z","end":"2026-05-09T17:40:53.817777Z","steps":["trace[1450210805] 'read index received'  (duration: 2.493788ms)","trace[1450210805] 'applied index is now lower than readState.Index'  (duration: 302.301379ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:53.81792Z","caller":"traceutil/trace.go:171","msg":"trace[1953600921] transaction","detail":"{read_only:false; response_revision:24206; number_of_response:1; }","duration":"318.641295ms","start":"2026-05-09T17:40:53.499232Z","end":"2026-05-09T17:40:53.817873Z","steps":["trace[1953600921] 'process raft request'  (duration: 222.555106ms)","trace[1953600921] 'compare'  (duration: 95.781831ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:53.81807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:53.499212Z","time spent":"318.779158ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24192 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T17:40:53.818082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.096126ms","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-05-09T17:40:53.818121Z","caller":"traceutil/trace.go:171","msg":"trace[1192150463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24206; }","duration":"305.157177ms","start":"2026-05-09T17:40:53.512953Z","end":"2026-05-09T17:40:53.81811Z","steps":["trace[1192150463] 'agreement among raft nodes before linearized reading'  (duration: 304.974802ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:53.818157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:53.512834Z","time spent":"305.312561ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-09T17:40:54.007394Z","caller":"traceutil/trace.go:171","msg":"trace[1234454920] transaction","detail":"{read_only:false; response_revision:24209; number_of_response:1; }","duration":"184.323044ms","start":"2026-05-09T17:40:53.823047Z","end":"2026-05-09T17:40:54.007371Z","steps":["trace[1234454920] 'process raft request'  (duration: 184.294533ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:54.007569Z","caller":"traceutil/trace.go:171","msg":"trace[1111110095] transaction","detail":"{read_only:false; response_revision:24207; number_of_response:1; }","duration":"487.274301ms","start":"2026-05-09T17:40:53.520265Z","end":"2026-05-09T17:40:54.00754Z","steps":["trace[1111110095] 'process raft request'  (duration: 426.328829ms)","trace[1111110095] 'compare'  (duration: 60.594972ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:54.007646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:53.52024Z","time spent":"487.348343ms","remote":"127.0.0.1:57800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.246\" mod_revision:24076 > success:<request_put:<key:\"/registry/masterleases/199.204.45.246\" value_size:68 lease:1613588348027996052 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.246\" > >"}
{"level":"info","ts":"2026-05-09T17:40:54.007864Z","caller":"traceutil/trace.go:171","msg":"trace[1435189871] transaction","detail":"{read_only:false; response_revision:24208; number_of_response:1; }","duration":"468.368105ms","start":"2026-05-09T17:40:53.539488Z","end":"2026-05-09T17:40:54.007856Z","steps":["trace[1435189871] 'process raft request'  (duration: 467.80707ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:54.007909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:53.539463Z","time spent":"468.422847ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24195 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-09T17:40:54.008026Z","caller":"traceutil/trace.go:171","msg":"trace[977822633] linearizableReadLoop","detail":"{readStateIndex:24989; appliedIndex:24987; }","duration":"190.093222ms","start":"2026-05-09T17:40:53.817895Z","end":"2026-05-09T17:40:54.007988Z","steps":["trace[977822633] 'read index received'  (duration: 128.729019ms)","trace[977822633] 'applied index is now lower than readState.Index'  (duration: 61.361173ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:54.008073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.114338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-09T17:40:54.008165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.375813ms","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-05-09T17:40:54.008185Z","caller":"traceutil/trace.go:171","msg":"trace[1079255812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24209; }","duration":"487.418225ms","start":"2026-05-09T17:40:53.52076Z","end":"2026-05-09T17:40:54.008178Z","steps":["trace[1079255812] 'agreement among raft nodes before linearized reading'  (duration: 487.346613ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:54.008187Z","caller":"traceutil/trace.go:171","msg":"trace[394434025] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:24209; }","duration":"330.279622ms","start":"2026-05-09T17:40:53.677888Z","end":"2026-05-09T17:40:54.008168Z","steps":["trace[394434025] 'agreement among raft nodes before linearized reading'  (duration: 330.155998ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:54.008203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:53.520729Z","time spent":"487.470406ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-09T17:40:54.008273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:40:53.677857Z","time spent":"330.364944ms","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:40:54.008354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.503415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:54.008375Z","caller":"traceutil/trace.go:171","msg":"trace[1828181717] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:24209; }","duration":"156.563457ms","start":"2026-05-09T17:40:53.851804Z","end":"2026-05-09T17:40:54.008368Z","steps":["trace[1828181717] 'agreement among raft nodes before linearized reading'  (duration: 156.528506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:54.240954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.867417ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882771871 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24194 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:40:54.241124Z","caller":"traceutil/trace.go:171","msg":"trace[990620749] linearizableReadLoop","detail":"{readStateIndex:24991; appliedIndex:24990; }","duration":"227.687095ms","start":"2026-05-09T17:40:54.013421Z","end":"2026-05-09T17:40:54.241108Z","steps":["trace[990620749] 'read index received'  (duration: 122.645013ms)","trace[990620749] 'applied index is now lower than readState.Index'  (duration: 105.041132ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:54.24122Z","caller":"traceutil/trace.go:171","msg":"trace[1045074370] transaction","detail":"{read_only:false; response_revision:24210; number_of_response:1; }","duration":"228.069216ms","start":"2026-05-09T17:40:54.013076Z","end":"2026-05-09T17:40:54.241145Z","steps":["trace[1045074370] 'process raft request'  (duration: 122.915671ms)","trace[1045074370] 'compare'  (duration: 104.735574ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:54.241364Z","caller":"traceutil/trace.go:171","msg":"trace[622673006] transaction","detail":"{read_only:false; response_revision:24211; number_of_response:1; }","duration":"126.163428ms","start":"2026-05-09T17:40:54.11514Z","end":"2026-05-09T17:40:54.241304Z","steps":["trace[622673006] 'process raft request'  (duration: 125.924602ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:54.241425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.005374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-09T17:40:54.241471Z","caller":"traceutil/trace.go:171","msg":"trace[1316356764] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24211; }","duration":"228.091257ms","start":"2026-05-09T17:40:54.013367Z","end":"2026-05-09T17:40:54.241459Z","steps":["trace[1316356764] 'agreement among raft nodes before linearized reading'  (duration: 227.83552ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:54.241767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.519895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:40:54.241841Z","caller":"traceutil/trace.go:171","msg":"trace[40547859] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24211; }","duration":"171.643338ms","start":"2026-05-09T17:40:54.070177Z","end":"2026-05-09T17:40:54.24182Z","steps":["trace[40547859] 'agreement among raft nodes before linearized reading'  (duration: 171.126304ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:58.382995Z","caller":"traceutil/trace.go:171","msg":"trace[1642688425] linearizableReadLoop","detail":"{readStateIndex:25019; appliedIndex:25018; }","duration":"128.118202ms","start":"2026-05-09T17:40:58.25485Z","end":"2026-05-09T17:40:58.382968Z","steps":["trace[1642688425] 'read index received'  (duration: 127.840255ms)","trace[1642688425] 'applied index is now lower than readState.Index'  (duration: 277.037µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:58.38332Z","caller":"traceutil/trace.go:171","msg":"trace[982861519] transaction","detail":"{read_only:false; response_revision:24238; number_of_response:1; }","duration":"129.653244ms","start":"2026-05-09T17:40:58.253462Z","end":"2026-05-09T17:40:58.383116Z","steps":["trace[982861519] 'process raft request'  (duration: 129.312535ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:58.38345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.447151ms","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-05-09T17:40:58.3835Z","caller":"traceutil/trace.go:171","msg":"trace[1705489361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24238; }","duration":"128.697958ms","start":"2026-05-09T17:40:58.254792Z","end":"2026-05-09T17:40:58.38349Z","steps":["trace[1705489361] 'agreement among raft nodes before linearized reading'  (duration: 128.338649ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:58.542051Z","caller":"traceutil/trace.go:171","msg":"trace[2071153313] transaction","detail":"{read_only:false; response_revision:24239; number_of_response:1; }","duration":"153.632197ms","start":"2026-05-09T17:40:58.388392Z","end":"2026-05-09T17:40:58.542024Z","steps":["trace[2071153313] 'process raft request'  (duration: 153.454132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:58.565018Z","caller":"traceutil/trace.go:171","msg":"trace[1307312048] linearizableReadLoop","detail":"{readStateIndex:25021; appliedIndex:25019; }","duration":"164.726989ms","start":"2026-05-09T17:40:58.400263Z","end":"2026-05-09T17:40:58.56499Z","steps":["trace[1307312048] 'read index received'  (duration: 141.683161ms)","trace[1307312048] 'applied index is now lower than readState.Index'  (duration: 23.042718ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:58.565079Z","caller":"traceutil/trace.go:171","msg":"trace[1597126648] transaction","detail":"{read_only:false; response_revision:24241; number_of_response:1; }","duration":"137.617352ms","start":"2026-05-09T17:40:58.427428Z","end":"2026-05-09T17:40:58.565045Z","steps":["trace[1597126648] 'process raft request'  (duration: 137.5307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:58.565078Z","caller":"traceutil/trace.go:171","msg":"trace[1281192418] transaction","detail":"{read_only:false; response_revision:24240; number_of_response:1; }","duration":"176.437369ms","start":"2026-05-09T17:40:58.388607Z","end":"2026-05-09T17:40:58.565044Z","steps":["trace[1281192418] 'process raft request'  (duration: 176.262004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:58.565244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.244404ms","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-05-09T17:40:58.565281Z","caller":"traceutil/trace.go:171","msg":"trace[283081066] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24241; }","duration":"158.338746ms","start":"2026-05-09T17:40:58.406929Z","end":"2026-05-09T17:40:58.565268Z","steps":["trace[283081066] 'agreement among raft nodes before linearized reading'  (duration: 158.196402ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:58.565259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.981967ms","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-05-09T17:40:58.565341Z","caller":"traceutil/trace.go:171","msg":"trace[1484935700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24241; }","duration":"165.11527ms","start":"2026-05-09T17:40:58.400209Z","end":"2026-05-09T17:40:58.565324Z","steps":["trace[1484935700] 'agreement among raft nodes before linearized reading'  (duration: 164.905095ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:58.716786Z","caller":"traceutil/trace.go:171","msg":"trace[642145370] transaction","detail":"{read_only:false; response_revision:24242; number_of_response:1; }","duration":"147.369857ms","start":"2026-05-09T17:40:58.569369Z","end":"2026-05-09T17:40:58.716739Z","steps":["trace[642145370] 'process raft request'  (duration: 133.347815ms)","trace[642145370] 'compare'  (duration: 13.643122ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:58.716835Z","caller":"traceutil/trace.go:171","msg":"trace[1036749118] transaction","detail":"{read_only:false; response_revision:24243; number_of_response:1; }","duration":"147.093569ms","start":"2026-05-09T17:40:58.569718Z","end":"2026-05-09T17:40:58.716812Z","steps":["trace[1036749118] 'process raft request'  (duration: 146.790161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:59.050294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.089319ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882771950 > lease_revoke:<id:16649e0da9eb0657>","response":"size:29"}
{"level":"info","ts":"2026-05-09T17:40:59.050887Z","caller":"traceutil/trace.go:171","msg":"trace[1316823436] linearizableReadLoop","detail":"{readStateIndex:25025; appliedIndex:25024; }","duration":"185.566417ms","start":"2026-05-09T17:40:58.865294Z","end":"2026-05-09T17:40:59.050861Z","steps":["trace[1316823436] 'read index received'  (duration: 15.899233ms)","trace[1316823436] 'applied index is now lower than readState.Index'  (duration: 169.664464ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:40:59.051039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.731611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:59.051099Z","caller":"traceutil/trace.go:171","msg":"trace[1484245006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24244; }","duration":"185.832094ms","start":"2026-05-09T17:40:58.865248Z","end":"2026-05-09T17:40:59.05108Z","steps":["trace[1484245006] 'agreement among raft nodes before linearized reading'  (duration: 185.732761ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:40:59.264334Z","caller":"traceutil/trace.go:171","msg":"trace[1185158485] linearizableReadLoop","detail":"{readStateIndex:25027; appliedIndex:25026; }","duration":"213.360835ms","start":"2026-05-09T17:40:59.050952Z","end":"2026-05-09T17:40:59.264313Z","steps":["trace[1185158485] 'read index received'  (duration: 212.693917ms)","trace[1185158485] 'applied index is now lower than readState.Index'  (duration: 666.098µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:40:59.264531Z","caller":"traceutil/trace.go:171","msg":"trace[61563468] transaction","detail":"{read_only:false; response_revision:24245; number_of_response:1; }","duration":"224.108868ms","start":"2026-05-09T17:40:59.040364Z","end":"2026-05-09T17:40:59.264473Z","steps":["trace[61563468] 'process raft request'  (duration: 223.293616ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:59.264519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.698219ms","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-05-09T17:40:59.26475Z","caller":"traceutil/trace.go:171","msg":"trace[1241478231] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24245; }","duration":"245.015897ms","start":"2026-05-09T17:40:59.019719Z","end":"2026-05-09T17:40:59.264735Z","steps":["trace[1241478231] 'agreement among raft nodes before linearized reading'  (duration: 244.711789ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:40:59.266311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.122859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:40:59.266375Z","caller":"traceutil/trace.go:171","msg":"trace[1415669096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24247; }","duration":"213.245062ms","start":"2026-05-09T17:40:59.053115Z","end":"2026-05-09T17:40:59.26636Z","steps":["trace[1415669096] 'agreement among raft nodes before linearized reading'  (duration: 213.087908ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:04.55537Z","caller":"traceutil/trace.go:171","msg":"trace[637469490] linearizableReadLoop","detail":"{readStateIndex:25066; appliedIndex:25065; }","duration":"117.700237ms","start":"2026-05-09T17:41:04.437646Z","end":"2026-05-09T17:41:04.555346Z","steps":["trace[637469490] 'read index received'  (duration: 117.475691ms)","trace[637469490] 'applied index is now lower than readState.Index'  (duration: 223.516µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:04.555402Z","caller":"traceutil/trace.go:171","msg":"trace[2078196859] transaction","detail":"{read_only:false; response_revision:24283; number_of_response:1; }","duration":"155.21992ms","start":"2026-05-09T17:41:04.400155Z","end":"2026-05-09T17:41:04.555375Z","steps":["trace[2078196859] 'process raft request'  (duration: 155.034255ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:04.55563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.964024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:41:04.555675Z","caller":"traceutil/trace.go:171","msg":"trace[1210107838] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24283; }","duration":"118.043517ms","start":"2026-05-09T17:41:04.437618Z","end":"2026-05-09T17:41:04.555661Z","steps":["trace[1210107838] 'agreement among raft nodes before linearized reading'  (duration: 117.824141ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:04.896426Z","caller":"traceutil/trace.go:171","msg":"trace[1296621451] linearizableReadLoop","detail":"{readStateIndex:25069; appliedIndex:25068; }","duration":"149.382502ms","start":"2026-05-09T17:41:04.74702Z","end":"2026-05-09T17:41:04.896402Z","steps":["trace[1296621451] 'read index received'  (duration: 119.498088ms)","trace[1296621451] 'applied index is now lower than readState.Index'  (duration: 29.883524ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:04.896455Z","caller":"traceutil/trace.go:171","msg":"trace[158158651] transaction","detail":"{read_only:false; response_revision:24286; number_of_response:1; }","duration":"260.354676ms","start":"2026-05-09T17:41:04.636062Z","end":"2026-05-09T17:41:04.896417Z","steps":["trace[158158651] 'process raft request'  (duration: 230.507482ms)","trace[158158651] 'compare'  (duration: 29.551566ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:04.896659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.627139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-09T17:41:04.896746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.525936ms","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-05-09T17:41:04.896819Z","caller":"traceutil/trace.go:171","msg":"trace[1850822767] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24286; }","duration":"149.626159ms","start":"2026-05-09T17:41:04.747178Z","end":"2026-05-09T17:41:04.896804Z","steps":["trace[1850822767] 'agreement among raft nodes before linearized reading'  (duration: 149.356922ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:04.89699Z","caller":"traceutil/trace.go:171","msg":"trace[523437862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24286; }","duration":"149.761332ms","start":"2026-05-09T17:41:04.746957Z","end":"2026-05-09T17:41:04.896718Z","steps":["trace[523437862] 'agreement among raft nodes before linearized reading'  (duration: 149.566727ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:04.897062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.77349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:04.897168Z","caller":"traceutil/trace.go:171","msg":"trace[248579464] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24286; }","duration":"121.911273ms","start":"2026-05-09T17:41:04.775235Z","end":"2026-05-09T17:41:04.897147Z","steps":["trace[248579464] 'agreement among raft nodes before linearized reading'  (duration: 121.662167ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:05.190538Z","caller":"traceutil/trace.go:171","msg":"trace[256072077] linearizableReadLoop","detail":"{readStateIndex:25072; appliedIndex:25070; }","duration":"199.942131ms","start":"2026-05-09T17:41:04.990576Z","end":"2026-05-09T17:41:05.190518Z","steps":["trace[256072077] 'read index received'  (duration: 199.824037ms)","trace[256072077] 'applied index is now lower than readState.Index'  (duration: 117.134µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:05.190554Z","caller":"traceutil/trace.go:171","msg":"trace[1353700307] transaction","detail":"{read_only:false; response_revision:24288; number_of_response:1; }","duration":"289.247824ms","start":"2026-05-09T17:41:04.901279Z","end":"2026-05-09T17:41:05.190527Z","steps":["trace[1353700307] 'process raft request'  (duration: 289.060889ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:05.190663Z","caller":"traceutil/trace.go:171","msg":"trace[2059101789] transaction","detail":"{read_only:false; response_revision:24289; number_of_response:1; }","duration":"268.506468ms","start":"2026-05-09T17:41:04.922128Z","end":"2026-05-09T17:41:05.190634Z","steps":["trace[2059101789] 'process raft request'  (duration: 268.352244ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:05.19074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.152726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:41:05.190956Z","caller":"traceutil/trace.go:171","msg":"trace[1570726092] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24289; }","duration":"200.439414ms","start":"2026-05-09T17:41:04.990503Z","end":"2026-05-09T17:41:05.190942Z","steps":["trace[1570726092] 'agreement among raft nodes before linearized reading'  (duration: 200.112245ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:05.319641Z","caller":"traceutil/trace.go:171","msg":"trace[938037896] linearizableReadLoop","detail":"{readStateIndex:25073; appliedIndex:25072; }","duration":"129.026866ms","start":"2026-05-09T17:41:05.190592Z","end":"2026-05-09T17:41:05.319619Z","steps":["trace[938037896] 'read index received'  (duration: 127.295899ms)","trace[938037896] 'applied index is now lower than readState.Index'  (duration: 1.729767ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:05.319831Z","caller":"traceutil/trace.go:171","msg":"trace[1003351035] transaction","detail":"{read_only:false; response_revision:24290; number_of_response:1; }","duration":"252.774178ms","start":"2026-05-09T17:41:05.067048Z","end":"2026-05-09T17:41:05.319822Z","steps":["trace[1003351035] 'process raft request'  (duration: 250.827445ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:05.319904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.539906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:05.319988Z","caller":"traceutil/trace.go:171","msg":"trace[920999371] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24290; }","duration":"222.683639ms","start":"2026-05-09T17:41:05.097285Z","end":"2026-05-09T17:41:05.319968Z","steps":["trace[920999371] 'agreement among raft nodes before linearized reading'  (duration: 222.530055ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:05.614521Z","caller":"traceutil/trace.go:171","msg":"trace[959329824] transaction","detail":"{read_only:false; response_revision:24291; number_of_response:1; }","duration":"344.445777ms","start":"2026-05-09T17:41:05.270037Z","end":"2026-05-09T17:41:05.614483Z","steps":["trace[959329824] 'process raft request'  (duration: 309.287499ms)","trace[959329824] 'compare'  (duration: 34.898961ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:05.61476Z","caller":"traceutil/trace.go:171","msg":"trace[1730227591] transaction","detail":"{read_only:false; response_revision:24292; number_of_response:1; }","duration":"330.107558ms","start":"2026-05-09T17:41:05.284603Z","end":"2026-05-09T17:41:05.614711Z","steps":["trace[1730227591] 'process raft request'  (duration: 329.81411ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:05.614717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:05.270014Z","time spent":"344.587142ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24252 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:516 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:05.614882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:05.284578Z","time spent":"330.248812ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24275 > 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-05-09T17:41:05.615172Z","caller":"traceutil/trace.go:171","msg":"trace[1078706210] transaction","detail":"{read_only:false; response_revision:24293; number_of_response:1; }","duration":"329.588723ms","start":"2026-05-09T17:41:05.285571Z","end":"2026-05-09T17:41:05.615159Z","steps":["trace[1078706210] 'process raft request'  (duration: 329.069529ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:05.615248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:05.285556Z","time spent":"329.654744ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24276 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-09T17:41:05.615546Z","caller":"traceutil/trace.go:171","msg":"trace[1765358344] transaction","detail":"{read_only:false; response_revision:24294; number_of_response:1; }","duration":"328.794911ms","start":"2026-05-09T17:41:05.286706Z","end":"2026-05-09T17:41:05.615501Z","steps":["trace[1765358344] 'process raft request'  (duration: 328.40596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:05.615538Z","caller":"traceutil/trace.go:171","msg":"trace[1436103491] linearizableReadLoop","detail":"{readStateIndex:25077; appliedIndex:25073; }","duration":"295.785751ms","start":"2026-05-09T17:41:05.319691Z","end":"2026-05-09T17:41:05.615477Z","steps":["trace[1436103491] 'read index received'  (duration: 259.539833ms)","trace[1436103491] 'applied index is now lower than readState.Index'  (duration: 36.241928ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:05.61568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.388048ms","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-05-09T17:41:05.615709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.384459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18572"}
{"level":"info","ts":"2026-05-09T17:41:05.615748Z","caller":"traceutil/trace.go:171","msg":"trace[756066725] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24294; }","duration":"365.522142ms","start":"2026-05-09T17:41:05.250204Z","end":"2026-05-09T17:41:05.615726Z","steps":["trace[756066725] 'agreement among raft nodes before linearized reading'  (duration: 365.297796ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:05.615768Z","caller":"traceutil/trace.go:171","msg":"trace[55969553] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24294; }","duration":"423.472672ms","start":"2026-05-09T17:41:05.192283Z","end":"2026-05-09T17:41:05.615755Z","steps":["trace[55969553] 'agreement among raft nodes before linearized reading'  (duration: 423.291297ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:05.615801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:05.192267Z","time spent":"423.526523ms","remote":"127.0.0.1:57926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18595,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-05-09T17:41:05.615786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:05.286694Z","time spent":"328.964776ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24277 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:05.615808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:05.250186Z","time spent":"365.602955ms","remote":"127.0.0.1:35628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-05-09T17:41:06.297314Z","caller":"traceutil/trace.go:171","msg":"trace[1043362339] linearizableReadLoop","detail":"{readStateIndex:25079; appliedIndex:25078; }","duration":"150.721328ms","start":"2026-05-09T17:41:06.146558Z","end":"2026-05-09T17:41:06.297279Z","steps":["trace[1043362339] 'read index received'  (duration: 150.41407ms)","trace[1043362339] 'applied index is now lower than readState.Index'  (duration: 306.158µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:06.297425Z","caller":"traceutil/trace.go:171","msg":"trace[2121629760] transaction","detail":"{read_only:false; response_revision:24296; number_of_response:1; }","duration":"156.398343ms","start":"2026-05-09T17:41:06.140995Z","end":"2026-05-09T17:41:06.297393Z","steps":["trace[2121629760] 'process raft request'  (duration: 156.090955ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:06.297537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.961394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-09T17:41:06.29758Z","caller":"traceutil/trace.go:171","msg":"trace[1343163192] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24296; }","duration":"151.074777ms","start":"2026-05-09T17:41:06.146494Z","end":"2026-05-09T17:41:06.297569Z","steps":["trace[1343163192] 'agreement among raft nodes before linearized reading'  (duration: 150.897542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:06.45028Z","caller":"traceutil/trace.go:171","msg":"trace[1213398210] transaction","detail":"{read_only:false; response_revision:24297; number_of_response:1; }","duration":"148.867367ms","start":"2026-05-09T17:41:06.301389Z","end":"2026-05-09T17:41:06.450256Z","steps":["trace[1213398210] 'process raft request'  (duration: 145.553437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:06.77882Z","caller":"traceutil/trace.go:171","msg":"trace[1539427851] transaction","detail":"{read_only:false; response_revision:24298; number_of_response:1; }","duration":"217.93196ms","start":"2026-05-09T17:41:06.560855Z","end":"2026-05-09T17:41:06.778787Z","steps":["trace[1539427851] 'process raft request'  (duration: 217.753965ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:06.800263Z","caller":"traceutil/trace.go:171","msg":"trace[1123918797] transaction","detail":"{read_only:false; response_revision:24299; number_of_response:1; }","duration":"166.017205ms","start":"2026-05-09T17:41:06.634217Z","end":"2026-05-09T17:41:06.800234Z","steps":["trace[1123918797] 'process raft request'  (duration: 165.84906ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:07.007794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.977995ms","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-05-09T17:41:07.007877Z","caller":"traceutil/trace.go:171","msg":"trace[1959503340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24300; }","duration":"107.101389ms","start":"2026-05-09T17:41:06.900755Z","end":"2026-05-09T17:41:07.007856Z","steps":["trace[1959503340] 'range keys from in-memory index tree'  (duration: 106.78147ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:07.163102Z","caller":"traceutil/trace.go:171","msg":"trace[1547119167] transaction","detail":"{read_only:false; response_revision:24302; number_of_response:1; }","duration":"151.659894ms","start":"2026-05-09T17:41:07.011415Z","end":"2026-05-09T17:41:07.163075Z","steps":["trace[1547119167] 'process raft request'  (duration: 149.828453ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:07.403644Z","caller":"traceutil/trace.go:171","msg":"trace[2097774910] transaction","detail":"{read_only:false; response_revision:24303; number_of_response:1; }","duration":"203.665612ms","start":"2026-05-09T17:41:07.199945Z","end":"2026-05-09T17:41:07.40361Z","steps":["trace[2097774910] 'process raft request'  (duration: 183.272095ms)","trace[2097774910] 'compare'  (duration: 20.063348ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:07.48786Z","caller":"traceutil/trace.go:171","msg":"trace[1091808116] transaction","detail":"{read_only:false; response_revision:24304; number_of_response:1; }","duration":"163.654841ms","start":"2026-05-09T17:41:07.32418Z","end":"2026-05-09T17:41:07.487835Z","steps":["trace[1091808116] 'process raft request'  (duration: 163.114926ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:08.082146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.09919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:41:08.082214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.000573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:41:08.082282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.101719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-09T17:41:08.082283Z","caller":"traceutil/trace.go:171","msg":"trace[240632411] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:24307; }","duration":"278.319665ms","start":"2026-05-09T17:41:07.803926Z","end":"2026-05-09T17:41:08.082245Z","steps":["trace[240632411] 'count revisions from in-memory index tree'  (duration: 277.984586ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:08.082307Z","caller":"traceutil/trace.go:171","msg":"trace[2014763015] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:24307; }","duration":"305.172297ms","start":"2026-05-09T17:41:07.777112Z","end":"2026-05-09T17:41:08.082284Z","steps":["trace[2014763015] 'count revisions from in-memory index tree'  (duration: 304.810207ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:08.082351Z","caller":"traceutil/trace.go:171","msg":"trace[1254428415] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24307; }","duration":"118.207192ms","start":"2026-05-09T17:41:07.964119Z","end":"2026-05-09T17:41:08.082326Z","steps":["trace[1254428415] 'range keys from in-memory index tree'  (duration: 117.842972ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:08.082374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:07.777086Z","time spent":"305.274361ms","remote":"127.0.0.1:52756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:41:08.082214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.764922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:08.08257Z","caller":"traceutil/trace.go:171","msg":"trace[1052146097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24307; }","duration":"219.142022ms","start":"2026-05-09T17:41:07.863397Z","end":"2026-05-09T17:41:08.082539Z","steps":["trace[1052146097] 'range keys from in-memory index tree'  (duration: 218.635778ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:08.082727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.537161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T17:41:08.082783Z","caller":"traceutil/trace.go:171","msg":"trace[2139603383] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:24307; }","duration":"209.738156ms","start":"2026-05-09T17:41:07.873017Z","end":"2026-05-09T17:41:08.082755Z","steps":["trace[2139603383] 'count revisions from in-memory index tree'  (duration: 209.452518ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:08.205916Z","caller":"traceutil/trace.go:171","msg":"trace[305834570] transaction","detail":"{read_only:false; response_revision:24308; number_of_response:1; }","duration":"120.170925ms","start":"2026-05-09T17:41:08.085717Z","end":"2026-05-09T17:41:08.205888Z","steps":["trace[305834570] 'process raft request'  (duration: 119.950269ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:08.545974Z","caller":"traceutil/trace.go:171","msg":"trace[615818247] transaction","detail":"{read_only:false; response_revision:24309; number_of_response:1; }","duration":"243.791174ms","start":"2026-05-09T17:41:08.302147Z","end":"2026-05-09T17:41:08.545938Z","steps":["trace[615818247] 'process raft request'  (duration: 243.583158ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.079104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.34587ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882772109 > lease_revoke:<id:16649e0da9eb0794>","response":"size:29"}
{"level":"info","ts":"2026-05-09T17:41:09.079369Z","caller":"traceutil/trace.go:171","msg":"trace[1226297538] linearizableReadLoop","detail":"{readStateIndex:25096; appliedIndex:25093; }","duration":"259.206865ms","start":"2026-05-09T17:41:08.820146Z","end":"2026-05-09T17:41:09.079353Z","steps":["trace[1226297538] 'read index received'  (duration: 150.085981ms)","trace[1226297538] 'applied index is now lower than readState.Index'  (duration: 109.119814ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:09.079488Z","caller":"traceutil/trace.go:171","msg":"trace[1309959627] transaction","detail":"{read_only:false; response_revision:24312; number_of_response:1; }","duration":"264.753696ms","start":"2026-05-09T17:41:08.814703Z","end":"2026-05-09T17:41:09.079457Z","steps":["trace[1309959627] 'process raft request'  (duration: 264.610123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.079539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.386269ms","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-05-09T17:41:09.0796Z","caller":"traceutil/trace.go:171","msg":"trace[605401514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24312; }","duration":"259.492412ms","start":"2026-05-09T17:41:08.820099Z","end":"2026-05-09T17:41:09.079592Z","steps":["trace[605401514] 'agreement among raft nodes before linearized reading'  (duration: 259.340128ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.079702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.790396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:09.079718Z","caller":"traceutil/trace.go:171","msg":"trace[817018718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24312; }","duration":"213.838627ms","start":"2026-05-09T17:41:08.865874Z","end":"2026-05-09T17:41:09.079712Z","steps":["trace[817018718] 'agreement among raft nodes before linearized reading'  (duration: 213.806416ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:09.080633Z","caller":"traceutil/trace.go:171","msg":"trace[1316242943] transaction","detail":"{read_only:false; response_revision:24311; number_of_response:1; }","duration":"296.238343ms","start":"2026-05-09T17:41:08.784368Z","end":"2026-05-09T17:41:09.080606Z","steps":["trace[1316242943] 'process raft request'  (duration: 294.826245ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.55982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.171703ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:09.559952Z","caller":"traceutil/trace.go:171","msg":"trace[1434871201] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24313; }","duration":"161.311027ms","start":"2026-05-09T17:41:09.398618Z","end":"2026-05-09T17:41:09.559929Z","steps":["trace[1434871201] 'range keys from in-memory index tree'  (duration: 161.156202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.560162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.298301ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882772116 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24301 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:41:09.560222Z","caller":"traceutil/trace.go:171","msg":"trace[613903153] linearizableReadLoop","detail":"{readStateIndex:25098; appliedIndex:25097; }","duration":"392.752595ms","start":"2026-05-09T17:41:09.167461Z","end":"2026-05-09T17:41:09.560213Z","steps":["trace[613903153] 'read index received'  (duration: 102.425512ms)","trace[613903153] 'applied index is now lower than readState.Index'  (duration: 290.325843ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:09.560402Z","caller":"traceutil/trace.go:171","msg":"trace[1132693113] transaction","detail":"{read_only:false; response_revision:24314; number_of_response:1; }","duration":"475.402468ms","start":"2026-05-09T17:41:09.084982Z","end":"2026-05-09T17:41:09.560385Z","steps":["trace[1132693113] 'process raft request'  (duration: 184.827748ms)","trace[1132693113] 'compare'  (duration: 290.200469ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:09.560461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:09.084959Z","time spent":"475.474569ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24301 > 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-05-09T17:41:09.560725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.247549ms","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-05-09T17:41:09.560884Z","caller":"traceutil/trace.go:171","msg":"trace[1929061605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24314; }","duration":"393.492525ms","start":"2026-05-09T17:41:09.167363Z","end":"2026-05-09T17:41:09.560856Z","steps":["trace[1929061605] 'agreement among raft nodes before linearized reading'  (duration: 392.978772ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.561292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:09.167326Z","time spent":"393.949238ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-09T17:41:09.571505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.415588ms","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-05-09T17:41:09.57164Z","caller":"traceutil/trace.go:171","msg":"trace[1236212331] 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:24315; }","duration":"249.566302ms","start":"2026-05-09T17:41:09.322049Z","end":"2026-05-09T17:41:09.571616Z","steps":["trace[1236212331] 'agreement among raft nodes before linearized reading'  (duration: 249.347076ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.571656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.211989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:41:09.57186Z","caller":"traceutil/trace.go:171","msg":"trace[1550470012] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24315; }","duration":"163.324592ms","start":"2026-05-09T17:41:09.408383Z","end":"2026-05-09T17:41:09.571708Z","steps":["trace[1550470012] 'agreement among raft nodes before linearized reading'  (duration: 163.065575ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:09.931599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.961546ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882772125 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:24305 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:41:09.931728Z","caller":"traceutil/trace.go:171","msg":"trace[152482603] transaction","detail":"{read_only:false; response_revision:24318; number_of_response:1; }","duration":"260.85046ms","start":"2026-05-09T17:41:09.670856Z","end":"2026-05-09T17:41:09.931707Z","steps":["trace[152482603] 'process raft request'  (duration: 135.694688ms)","trace[152482603] 'compare'  (duration: 124.465843ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:10.245862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.05932ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882772126 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24307 > 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:18"}
{"level":"info","ts":"2026-05-09T17:41:10.246237Z","caller":"traceutil/trace.go:171","msg":"trace[1612368789] transaction","detail":"{read_only:false; response_revision:24320; number_of_response:1; }","duration":"561.644046ms","start":"2026-05-09T17:41:09.684547Z","end":"2026-05-09T17:41:10.246191Z","steps":["trace[1612368789] 'process raft request'  (duration: 561.438251ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:10.246384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:09.684539Z","time spent":"561.76372ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24306 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T17:41:10.246744Z","caller":"traceutil/trace.go:171","msg":"trace[1276019201] transaction","detail":"{read_only:false; response_revision:24319; number_of_response:1; }","duration":"562.624924ms","start":"2026-05-09T17:41:09.684099Z","end":"2026-05-09T17:41:10.246724Z","steps":["trace[1276019201] 'process raft request'  (duration: 451.534636ms)","trace[1276019201] 'compare'  (duration: 109.880274ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:10.246829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:09.684076Z","time spent":"562.718797ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24307 > 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-05-09T17:41:10.576545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.915992ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882772129 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24308 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:41:10.576658Z","caller":"traceutil/trace.go:171","msg":"trace[1942496940] linearizableReadLoop","detail":"{readStateIndex:25105; appliedIndex:25104; }","duration":"290.974501ms","start":"2026-05-09T17:41:10.285666Z","end":"2026-05-09T17:41:10.576641Z","steps":["trace[1942496940] 'read index received'  (duration: 95.809022ms)","trace[1942496940] 'applied index is now lower than readState.Index'  (duration: 195.164029ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:10.576764Z","caller":"traceutil/trace.go:171","msg":"trace[344597071] transaction","detail":"{read_only:false; response_revision:24321; number_of_response:1; }","duration":"325.264965ms","start":"2026-05-09T17:41:10.251486Z","end":"2026-05-09T17:41:10.576751Z","steps":["trace[344597071] 'process raft request'  (duration: 130.017074ms)","trace[344597071] 'compare'  (duration: 194.505621ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:10.576839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:10.25147Z","time spent":"325.324356ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24308 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:10.576962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.282349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"}
{"level":"info","ts":"2026-05-09T17:41:10.577048Z","caller":"traceutil/trace.go:171","msg":"trace[465950421] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:24321; }","duration":"291.436723ms","start":"2026-05-09T17:41:10.285589Z","end":"2026-05-09T17:41:10.577026Z","steps":["trace[465950421] 'agreement among raft nodes before linearized reading'  (duration: 291.189207ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:10.630163Z","caller":"traceutil/trace.go:171","msg":"trace[1695723120] transaction","detail":"{read_only:false; response_revision:24322; number_of_response:1; }","duration":"186.77697ms","start":"2026-05-09T17:41:10.443365Z","end":"2026-05-09T17:41:10.630142Z","steps":["trace[1695723120] 'process raft request'  (duration: 186.652997ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:10.965145Z","caller":"traceutil/trace.go:171","msg":"trace[1304655895] transaction","detail":"{read_only:false; response_revision:24323; number_of_response:1; }","duration":"413.235202ms","start":"2026-05-09T17:41:10.551887Z","end":"2026-05-09T17:41:10.965122Z","steps":["trace[1304655895] 'process raft request'  (duration: 413.083388ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:10.965264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:10.551851Z","time spent":"413.351506ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24309 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-09T17:41:10.965366Z","caller":"traceutil/trace.go:171","msg":"trace[2068852494] transaction","detail":"{read_only:false; response_revision:24324; number_of_response:1; }","duration":"344.722246ms","start":"2026-05-09T17:41:10.620637Z","end":"2026-05-09T17:41:10.965359Z","steps":["trace[2068852494] 'process raft request'  (duration: 344.454599ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:10.96536Z","caller":"traceutil/trace.go:171","msg":"trace[941097666] linearizableReadLoop","detail":"{readStateIndex:25107; appliedIndex:25105; }","duration":"388.618092ms","start":"2026-05-09T17:41:10.576721Z","end":"2026-05-09T17:41:10.965339Z","steps":["trace[941097666] 'read index received'  (duration: 53.382905ms)","trace[941097666] 'applied index is now lower than readState.Index'  (duration: 335.232977ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:10.965397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:10.620624Z","time spent":"344.754766ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24291 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:10.965547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.377584ms","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-05-09T17:41:10.965579Z","caller":"traceutil/trace.go:171","msg":"trace[1074384986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24324; }","duration":"392.470346ms","start":"2026-05-09T17:41:10.573098Z","end":"2026-05-09T17:41:10.965569Z","steps":["trace[1074384986] 'agreement among raft nodes before linearized reading'  (duration: 392.335243ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:10.965611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:10.573074Z","time spent":"392.529228ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-09T17:41:10.965603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.956702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c2514178-7a8a-41c2-8cab-191dcc5809e8\" ","response":"range_response_count:1 size:1322"}
{"level":"warn","ts":"2026-05-09T17:41:10.965638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.807936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:41:10.965666Z","caller":"traceutil/trace.go:171","msg":"trace[1306626308] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c2514178-7a8a-41c2-8cab-191dcc5809e8; range_end:; response_count:1; response_revision:24324; }","duration":"385.095986ms","start":"2026-05-09T17:41:10.580554Z","end":"2026-05-09T17:41:10.96565Z","steps":["trace[1306626308] 'agreement among raft nodes before linearized reading'  (duration: 384.90455ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:10.965693Z","caller":"traceutil/trace.go:171","msg":"trace[1097628862] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24324; }","duration":"330.903508ms","start":"2026-05-09T17:41:10.634776Z","end":"2026-05-09T17:41:10.965679Z","steps":["trace[1097628862] 'agreement among raft nodes before linearized reading'  (duration: 330.747064ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:10.965653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.465765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:41:10.96573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:10.634754Z","time spent":"330.968021ms","remote":"127.0.0.1:57932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-09T17:41:10.965768Z","caller":"traceutil/trace.go:171","msg":"trace[1864007269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24324; }","duration":"101.680331ms","start":"2026-05-09T17:41:10.864065Z","end":"2026-05-09T17:41:10.965745Z","steps":["trace[1864007269] 'agreement among raft nodes before linearized reading'  (duration: 101.445705ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:10.965703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:10.58054Z","time spent":"385.155847ms","remote":"127.0.0.1:57898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1345,"request content":"key:\"/registry/persistentvolumes/pvc-c2514178-7a8a-41c2-8cab-191dcc5809e8\" "}
{"level":"warn","ts":"2026-05-09T17:41:11.168088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.491652ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882772137 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24310 > 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-05-09T17:41:11.168191Z","caller":"traceutil/trace.go:171","msg":"trace[1344433968] linearizableReadLoop","detail":"{readStateIndex:25109; appliedIndex:25108; }","duration":"197.892774ms","start":"2026-05-09T17:41:10.970281Z","end":"2026-05-09T17:41:11.168174Z","steps":["trace[1344433968] 'read index received'  (duration: 44.169764ms)","trace[1344433968] 'applied index is now lower than readState.Index'  (duration: 153.72177ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:11.168264Z","caller":"traceutil/trace.go:171","msg":"trace[2123716054] transaction","detail":"{read_only:false; response_revision:24325; number_of_response:1; }","duration":"198.096319ms","start":"2026-05-09T17:41:10.970116Z","end":"2026-05-09T17:41:11.168212Z","steps":["trace[2123716054] 'process raft request'  (duration: 44.40439ms)","trace[2123716054] 'compare'  (duration: 153.373079ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:11.169084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.769127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:41:11.169187Z","caller":"traceutil/trace.go:171","msg":"trace[1967044705] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24325; }","duration":"198.910682ms","start":"2026-05-09T17:41:10.970254Z","end":"2026-05-09T17:41:11.169165Z","steps":["trace[1967044705] 'agreement among raft nodes before linearized reading'  (duration: 197.984077ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:11.322119Z","caller":"traceutil/trace.go:171","msg":"trace[1014925185] linearizableReadLoop","detail":"{readStateIndex:25112; appliedIndex:25111; }","duration":"110.808209ms","start":"2026-05-09T17:41:11.211284Z","end":"2026-05-09T17:41:11.322092Z","steps":["trace[1014925185] 'read index received'  (duration: 106.675937ms)","trace[1014925185] 'applied index is now lower than readState.Index'  (duration: 4.130752ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:11.322224Z","caller":"traceutil/trace.go:171","msg":"trace[1081181547] transaction","detail":"{read_only:false; response_revision:24328; number_of_response:1; }","duration":"144.677023ms","start":"2026-05-09T17:41:11.177516Z","end":"2026-05-09T17:41:11.322193Z","steps":["trace[1081181547] 'process raft request'  (duration: 140.51366ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:11.322336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.017826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:11.322383Z","caller":"traceutil/trace.go:171","msg":"trace[1562681492] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:24328; }","duration":"111.096768ms","start":"2026-05-09T17:41:11.211274Z","end":"2026-05-09T17:41:11.32237Z","steps":["trace[1562681492] 'agreement among raft nodes before linearized reading'  (duration: 110.969964ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:11.837484Z","caller":"traceutil/trace.go:171","msg":"trace[926712439] linearizableReadLoop","detail":"{readStateIndex:25114; appliedIndex:25113; }","duration":"191.91063ms","start":"2026-05-09T17:41:11.645545Z","end":"2026-05-09T17:41:11.837455Z","steps":["trace[926712439] 'read index received'  (duration: 191.415756ms)","trace[926712439] 'applied index is now lower than readState.Index'  (duration: 493.674µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:11.837497Z","caller":"traceutil/trace.go:171","msg":"trace[2064757704] transaction","detail":"{read_only:false; response_revision:24330; number_of_response:1; }","duration":"260.461129ms","start":"2026-05-09T17:41:11.577007Z","end":"2026-05-09T17:41:11.837468Z","steps":["trace[2064757704] 'process raft request'  (duration: 259.972556ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:11.837705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.764942ms","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-05-09T17:41:11.837736Z","caller":"traceutil/trace.go:171","msg":"trace[380880766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24330; }","duration":"200.855505ms","start":"2026-05-09T17:41:11.636872Z","end":"2026-05-09T17:41:11.837728Z","steps":["trace[380880766] 'agreement among raft nodes before linearized reading'  (duration: 200.69108ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:11.838413Z","caller":"traceutil/trace.go:171","msg":"trace[1579741954] transaction","detail":"{read_only:false; response_revision:24331; number_of_response:1; }","duration":"187.533892ms","start":"2026-05-09T17:41:11.650864Z","end":"2026-05-09T17:41:11.838398Z","steps":["trace[1579741954] 'process raft request'  (duration: 187.287865ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:13.572155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.701404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:13.572243Z","caller":"traceutil/trace.go:171","msg":"trace[1249364123] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:24341; }","duration":"100.851378ms","start":"2026-05-09T17:41:13.471369Z","end":"2026-05-09T17:41:13.572221Z","steps":["trace[1249364123] 'count revisions from in-memory index tree'  (duration: 100.597762ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:13.572345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.021476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-09T17:41:13.57243Z","caller":"traceutil/trace.go:171","msg":"trace[839454789] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24341; }","duration":"246.161849ms","start":"2026-05-09T17:41:13.326247Z","end":"2026-05-09T17:41:13.572409Z","steps":["trace[839454789] 'range keys from in-memory index tree'  (duration: 245.8132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:16.816919Z","caller":"traceutil/trace.go:171","msg":"trace[1208214475] transaction","detail":"{read_only:false; response_revision:24424; number_of_response:1; }","duration":"212.113282ms","start":"2026-05-09T17:41:16.604774Z","end":"2026-05-09T17:41:16.816888Z","steps":["trace[1208214475] 'process raft request'  (duration: 211.951907ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:17.005396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.968852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:17.005462Z","caller":"traceutil/trace.go:171","msg":"trace[154633067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24424; }","duration":"141.077835ms","start":"2026-05-09T17:41:16.864367Z","end":"2026-05-09T17:41:17.005445Z","steps":["trace[154633067] 'range keys from in-memory index tree'  (duration: 140.781567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:17.255368Z","caller":"traceutil/trace.go:171","msg":"trace[2022887359] linearizableReadLoop","detail":"{readStateIndex:25211; appliedIndex:25211; }","duration":"171.01612ms","start":"2026-05-09T17:41:17.084332Z","end":"2026-05-09T17:41:17.255348Z","steps":["trace[2022887359] 'read index received'  (duration: 171.00528ms)","trace[2022887359] 'applied index is now lower than readState.Index'  (duration: 9.18µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:17.255354Z","caller":"traceutil/trace.go:171","msg":"trace[10470999] transaction","detail":"{read_only:false; response_revision:24426; number_of_response:1; }","duration":"242.639142ms","start":"2026-05-09T17:41:17.012691Z","end":"2026-05-09T17:41:17.25533Z","steps":["trace[10470999] 'process raft request'  (duration: 242.507088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:17.255657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.292909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:560"}
{"level":"info","ts":"2026-05-09T17:41:17.255744Z","caller":"traceutil/trace.go:171","msg":"trace[1997796009] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24426; }","duration":"171.452984ms","start":"2026-05-09T17:41:17.08427Z","end":"2026-05-09T17:41:17.255723Z","steps":["trace[1997796009] 'agreement among raft nodes before linearized reading'  (duration: 171.156275ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:19.440126Z","caller":"traceutil/trace.go:171","msg":"trace[1371730762] transaction","detail":"{read_only:false; response_revision:24444; number_of_response:1; }","duration":"169.965732ms","start":"2026-05-09T17:41:19.27013Z","end":"2026-05-09T17:41:19.440096Z","steps":["trace[1371730762] 'process raft request'  (duration: 169.768417ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:19.454376Z","caller":"traceutil/trace.go:171","msg":"trace[2110262874] linearizableReadLoop","detail":"{readStateIndex:25231; appliedIndex:25229; }","duration":"150.143582ms","start":"2026-05-09T17:41:19.304214Z","end":"2026-05-09T17:41:19.454358Z","steps":["trace[2110262874] 'read index received'  (duration: 135.708309ms)","trace[2110262874] 'applied index is now lower than readState.Index'  (duration: 14.434453ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:19.454523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.299295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:19.454553Z","caller":"traceutil/trace.go:171","msg":"trace[751698528] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:24445; }","duration":"150.390088ms","start":"2026-05-09T17:41:19.304155Z","end":"2026-05-09T17:41:19.454545Z","steps":["trace[751698528] 'agreement among raft nodes before linearized reading'  (duration: 150.313496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:19.454514Z","caller":"traceutil/trace.go:171","msg":"trace[1614319722] transaction","detail":"{read_only:false; response_revision:24445; number_of_response:1; }","duration":"182.787501ms","start":"2026-05-09T17:41:19.27167Z","end":"2026-05-09T17:41:19.454458Z","steps":["trace[1614319722] 'process raft request'  (duration: 182.562395ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:19.454617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.507942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:19.454713Z","caller":"traceutil/trace.go:171","msg":"trace[925076976] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24445; }","duration":"128.665487ms","start":"2026-05-09T17:41:19.326026Z","end":"2026-05-09T17:41:19.454692Z","steps":["trace[925076976] 'agreement among raft nodes before linearized reading'  (duration: 128.515752ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:19.454886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.02743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"warn","ts":"2026-05-09T17:41:19.454894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.662181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-09T17:41:19.454978Z","caller":"traceutil/trace.go:171","msg":"trace[939428456] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:24445; }","duration":"106.176294ms","start":"2026-05-09T17:41:19.348776Z","end":"2026-05-09T17:41:19.454952Z","steps":["trace[939428456] 'agreement among raft nodes before linearized reading'  (duration: 105.897336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:19.454988Z","caller":"traceutil/trace.go:171","msg":"trace[1032814659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24445; }","duration":"119.781905ms","start":"2026-05-09T17:41:19.335181Z","end":"2026-05-09T17:41:19.454963Z","steps":["trace[1032814659] 'agreement among raft nodes before linearized reading'  (duration: 119.511378ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:23.235515Z","caller":"traceutil/trace.go:171","msg":"trace[1971504296] transaction","detail":"{read_only:false; response_revision:24489; number_of_response:1; }","duration":"149.628488ms","start":"2026-05-09T17:41:23.085859Z","end":"2026-05-09T17:41:23.235487Z","steps":["trace[1971504296] 'process raft request'  (duration: 149.464754ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:23.476829Z","caller":"traceutil/trace.go:171","msg":"trace[1381037223] linearizableReadLoop","detail":"{readStateIndex:25276; appliedIndex:25275; }","duration":"332.641476ms","start":"2026-05-09T17:41:23.144151Z","end":"2026-05-09T17:41:23.476793Z","steps":["trace[1381037223] 'read index received'  (duration: 92.09968ms)","trace[1381037223] 'applied index is now lower than readState.Index'  (duration: 240.540346ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:23.476894Z","caller":"traceutil/trace.go:171","msg":"trace[774855600] transaction","detail":"{read_only:false; response_revision:24490; number_of_response:1; }","duration":"388.94475ms","start":"2026-05-09T17:41:23.087912Z","end":"2026-05-09T17:41:23.476856Z","steps":["trace[774855600] 'process raft request'  (duration: 290.291632ms)","trace[774855600] 'compare'  (duration: 98.310369ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:23.477044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:23.087899Z","time spent":"389.060104ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24468 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:23.477087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.908843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-05-09T17:41:23.477126Z","caller":"traceutil/trace.go:171","msg":"trace[1572823564] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24490; }","duration":"332.994235ms","start":"2026-05-09T17:41:23.144118Z","end":"2026-05-09T17:41:23.477112Z","steps":["trace[1572823564] 'agreement among raft nodes before linearized reading'  (duration: 332.79088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.477168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:23.144103Z","time spent":"333.057517ms","remote":"127.0.0.1:57900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1883,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"info","ts":"2026-05-09T17:41:23.638043Z","caller":"traceutil/trace.go:171","msg":"trace[1570973334] transaction","detail":"{read_only:false; response_revision:24491; number_of_response:1; }","duration":"393.151426ms","start":"2026-05-09T17:41:23.244871Z","end":"2026-05-09T17:41:23.638022Z","steps":["trace[1570973334] 'process raft request'  (duration: 392.55702ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.638168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:23.244851Z","time spent":"393.246459ms","remote":"127.0.0.1:58036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-manila-nvzl6\" mod_revision:24367 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nvzl6\" value_size:1351 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nvzl6\" > >"}
{"level":"info","ts":"2026-05-09T17:41:23.638427Z","caller":"traceutil/trace.go:171","msg":"trace[925017618] transaction","detail":"{read_only:false; response_revision:24492; number_of_response:1; }","duration":"393.494904ms","start":"2026-05-09T17:41:23.244923Z","end":"2026-05-09T17:41:23.638418Z","steps":["trace[925017618] 'process raft request'  (duration: 393.026812ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:23.638434Z","caller":"traceutil/trace.go:171","msg":"trace[415320905] transaction","detail":"{read_only:false; response_revision:24494; number_of_response:1; }","duration":"393.448843ms","start":"2026-05-09T17:41:23.244961Z","end":"2026-05-09T17:41:23.63841Z","steps":["trace[415320905] 'process raft request'  (duration: 393.34663ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.638475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:23.244903Z","time spent":"393.548297ms","remote":"127.0.0.1:57914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" mod_revision:24366 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" value_size:823 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" > >"}
{"level":"info","ts":"2026-05-09T17:41:23.638455Z","caller":"traceutil/trace.go:171","msg":"trace[958547138] transaction","detail":"{read_only:false; response_revision:24493; number_of_response:1; }","duration":"393.448483ms","start":"2026-05-09T17:41:23.244962Z","end":"2026-05-09T17:41:23.63841Z","steps":["trace[958547138] 'process raft request'  (duration: 393.263028ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.638607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:23.244936Z","time spent":"393.594107ms","remote":"127.0.0.1:58036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-659rv\" mod_revision:24361 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-659rv\" value_size:1420 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-659rv\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:23.638658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:23.244954Z","time spent":"393.626858ms","remote":"127.0.0.1:57914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-manila-nodes\" mod_revision:24363 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila-nodes\" value_size:873 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila-nodes\" > >"}
{"level":"info","ts":"2026-05-09T17:41:23.64135Z","caller":"traceutil/trace.go:171","msg":"trace[727630788] linearizableReadLoop","detail":"{readStateIndex:25282; appliedIndex:25276; }","duration":"160.474264ms","start":"2026-05-09T17:41:23.480859Z","end":"2026-05-09T17:41:23.641333Z","steps":["trace[727630788] 'read index received'  (duration: 156.472505ms)","trace[727630788] 'applied index is now lower than readState.Index'  (duration: 4.000939ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:23.641385Z","caller":"traceutil/trace.go:171","msg":"trace[678450481] transaction","detail":"{read_only:false; response_revision:24495; number_of_response:1; }","duration":"189.32316ms","start":"2026-05-09T17:41:23.45204Z","end":"2026-05-09T17:41:23.641364Z","steps":["trace[678450481] 'process raft request'  (duration: 189.160516ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:23.641446Z","caller":"traceutil/trace.go:171","msg":"trace[1055000621] transaction","detail":"{read_only:false; response_revision:24496; number_of_response:1; }","duration":"174.403754ms","start":"2026-05-09T17:41:23.467008Z","end":"2026-05-09T17:41:23.641412Z","steps":["trace[1055000621] 'process raft request'  (duration: 174.28569ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.64158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.71139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2dd73d80-5a43-4ec7-b47a-1ec99f57c5c8\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-09T17:41:23.641626Z","caller":"traceutil/trace.go:171","msg":"trace[1975664405] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2dd73d80-5a43-4ec7-b47a-1ec99f57c5c8; range_end:; response_count:1; response_revision:24496; }","duration":"160.787672ms","start":"2026-05-09T17:41:23.480825Z","end":"2026-05-09T17:41:23.641613Z","steps":["trace[1975664405] 'agreement among raft nodes before linearized reading'  (duration: 160.600817ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.641851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.07901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-09T17:41:23.641908Z","caller":"traceutil/trace.go:171","msg":"trace[612655776] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:24496; }","duration":"150.173073ms","start":"2026-05-09T17:41:23.491719Z","end":"2026-05-09T17:41:23.641892Z","steps":["trace[612655776] 'agreement among raft nodes before linearized reading'  (duration: 149.967787ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:23.641862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.000678ms","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-05-09T17:41:23.642132Z","caller":"traceutil/trace.go:171","msg":"trace[1897060420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24496; }","duration":"161.243604ms","start":"2026-05-09T17:41:23.48082Z","end":"2026-05-09T17:41:23.642064Z","steps":["trace[1897060420] 'agreement among raft nodes before linearized reading'  (duration: 160.961247ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:55.692074Z","caller":"traceutil/trace.go:171","msg":"trace[491016042] transaction","detail":"{read_only:false; response_revision:24752; number_of_response:1; }","duration":"108.326219ms","start":"2026-05-09T17:41:55.583715Z","end":"2026-05-09T17:41:55.692041Z","steps":["trace[491016042] 'process raft request'  (duration: 108.079833ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:55.886542Z","caller":"traceutil/trace.go:171","msg":"trace[963636767] transaction","detail":"{read_only:false; response_revision:24753; number_of_response:1; }","duration":"143.657552ms","start":"2026-05-09T17:41:55.742847Z","end":"2026-05-09T17:41:55.886505Z","steps":["trace[963636767] 'process raft request'  (duration: 120.843061ms)","trace[963636767] 'compare'  (duration: 22.661357ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:56.191617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.748556ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882773217 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24740 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T17:41:56.19187Z","caller":"traceutil/trace.go:171","msg":"trace[1048807402] transaction","detail":"{read_only:false; response_revision:24755; number_of_response:1; }","duration":"186.9864ms","start":"2026-05-09T17:41:56.004863Z","end":"2026-05-09T17:41:56.191849Z","steps":["trace[1048807402] 'process raft request'  (duration: 186.879587ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:56.191837Z","caller":"traceutil/trace.go:171","msg":"trace[255577364] transaction","detail":"{read_only:false; response_revision:24754; number_of_response:1; }","duration":"445.090368ms","start":"2026-05-09T17:41:55.746697Z","end":"2026-05-09T17:41:56.191787Z","steps":["trace[255577364] 'process raft request'  (duration: 262.013603ms)","trace[255577364] 'compare'  (duration: 182.53777ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:56.19206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:55.746683Z","time spent":"445.266552ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24740 > 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-05-09T17:41:56.192344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.321363ms","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-05-09T17:41:56.192394Z","caller":"traceutil/trace.go:171","msg":"trace[1227208850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24755; }","duration":"406.450647ms","start":"2026-05-09T17:41:55.785932Z","end":"2026-05-09T17:41:56.192383Z","steps":["trace[1227208850] 'agreement among raft nodes before linearized reading'  (duration: 406.244551ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.192423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:55.785887Z","time spent":"406.530048ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-09T17:41:56.192112Z","caller":"traceutil/trace.go:171","msg":"trace[1332915293] linearizableReadLoop","detail":"{readStateIndex:25548; appliedIndex:25546; }","duration":"406.055336ms","start":"2026-05-09T17:41:55.785993Z","end":"2026-05-09T17:41:56.192048Z","steps":["trace[1332915293] 'read index received'  (duration: 77.631793ms)","trace[1332915293] 'applied index is now lower than readState.Index'  (duration: 328.420682ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:56.203711Z","caller":"traceutil/trace.go:171","msg":"trace[1598882398] transaction","detail":"{read_only:false; response_revision:24757; number_of_response:1; }","duration":"104.346061ms","start":"2026-05-09T17:41:56.099314Z","end":"2026-05-09T17:41:56.203661Z","steps":["trace[1598882398] 'process raft request'  (duration: 104.207858ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.203889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.233754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-09T17:41:56.20388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.787884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:41:56.203959Z","caller":"traceutil/trace.go:171","msg":"trace[1945749606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24757; }","duration":"145.342577ms","start":"2026-05-09T17:41:56.0586Z","end":"2026-05-09T17:41:56.203943Z","steps":["trace[1945749606] 'agreement among raft nodes before linearized reading'  (duration: 145.08451ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:56.203977Z","caller":"traceutil/trace.go:171","msg":"trace[1047101610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24757; }","duration":"140.945349ms","start":"2026-05-09T17:41:56.063016Z","end":"2026-05-09T17:41:56.203961Z","steps":["trace[1047101610] 'agreement among raft nodes before linearized reading'  (duration: 140.699662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.204114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.25763ms","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-05-09T17:41:56.204178Z","caller":"traceutil/trace.go:171","msg":"trace[1685411519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24757; }","duration":"399.368914ms","start":"2026-05-09T17:41:55.804795Z","end":"2026-05-09T17:41:56.204164Z","steps":["trace[1685411519] 'agreement among raft nodes before linearized reading'  (duration: 398.801969ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.204219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:55.804772Z","time spent":"399.437905ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T17:41:56.204242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.875195ms","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-05-09T17:41:56.20397Z","caller":"traceutil/trace.go:171","msg":"trace[725565344] transaction","detail":"{read_only:false; response_revision:24756; number_of_response:1; }","duration":"168.513918ms","start":"2026-05-09T17:41:56.035415Z","end":"2026-05-09T17:41:56.203929Z","steps":["trace[725565344] 'process raft request'  (duration: 168.023415ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:56.204354Z","caller":"traceutil/trace.go:171","msg":"trace[56222920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24757; }","duration":"354.035139ms","start":"2026-05-09T17:41:55.850295Z","end":"2026-05-09T17:41:56.20433Z","steps":["trace[56222920] 'agreement among raft nodes before linearized reading'  (duration: 353.688739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.204404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:55.850278Z","time spent":"354.114251ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-09T17:41:56.51244Z","caller":"traceutil/trace.go:171","msg":"trace[166261896] transaction","detail":"{read_only:false; response_revision:24759; number_of_response:1; }","duration":"304.12761ms","start":"2026-05-09T17:41:56.208268Z","end":"2026-05-09T17:41:56.512396Z","steps":["trace[166261896] 'process raft request'  (duration: 237.851625ms)","trace[166261896] 'compare'  (duration: 65.844974ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:56.512644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:56.208246Z","time spent":"304.289495ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24745 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T17:41:56.514551Z","caller":"traceutil/trace.go:171","msg":"trace[958680942] transaction","detail":"{read_only:false; response_revision:24760; number_of_response:1; }","duration":"305.457836ms","start":"2026-05-09T17:41:56.209065Z","end":"2026-05-09T17:41:56.514523Z","steps":["trace[958680942] 'process raft request'  (duration: 305.248391ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.514714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:56.209046Z","time spent":"305.57576ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24746 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-09T17:41:56.514752Z","caller":"traceutil/trace.go:171","msg":"trace[1191740489] transaction","detail":"{read_only:false; response_revision:24762; number_of_response:1; }","duration":"304.806809ms","start":"2026-05-09T17:41:56.209936Z","end":"2026-05-09T17:41:56.514742Z","steps":["trace[1191740489] 'process raft request'  (duration: 304.555893ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.514844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:56.209915Z","time spent":"304.86569ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24743 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-09T17:41:56.514556Z","caller":"traceutil/trace.go:171","msg":"trace[578950872] transaction","detail":"{read_only:false; response_revision:24761; number_of_response:1; }","duration":"304.774538ms","start":"2026-05-09T17:41:56.20975Z","end":"2026-05-09T17:41:56.514525Z","steps":["trace[578950872] 'process raft request'  (duration: 304.678736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:56.514909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:56.209743Z","time spent":"305.140648ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24742 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-09T17:41:57.341012Z","caller":"traceutil/trace.go:171","msg":"trace[4989580] linearizableReadLoop","detail":"{readStateIndex:25559; appliedIndex:25558; }","duration":"166.830773ms","start":"2026-05-09T17:41:57.174147Z","end":"2026-05-09T17:41:57.340977Z","steps":["trace[4989580] 'read index received'  (duration: 166.645718ms)","trace[4989580] 'applied index is now lower than readState.Index'  (duration: 184.365µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:57.341109Z","caller":"traceutil/trace.go:171","msg":"trace[682259321] transaction","detail":"{read_only:false; response_revision:24765; number_of_response:1; }","duration":"193.951682ms","start":"2026-05-09T17:41:57.147117Z","end":"2026-05-09T17:41:57.341069Z","steps":["trace[682259321] 'process raft request'  (duration: 193.722686ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:57.341174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.012548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-09T17:41:57.3412Z","caller":"traceutil/trace.go:171","msg":"trace[982919387] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24765; }","duration":"167.10835ms","start":"2026-05-09T17:41:57.174083Z","end":"2026-05-09T17:41:57.341192Z","steps":["trace[982919387] 'agreement among raft nodes before linearized reading'  (duration: 166.991347ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:57.816605Z","caller":"traceutil/trace.go:171","msg":"trace[321005930] transaction","detail":"{read_only:false; response_revision:24766; number_of_response:1; }","duration":"119.092772ms","start":"2026-05-09T17:41:57.697486Z","end":"2026-05-09T17:41:57.816579Z","steps":["trace[321005930] 'process raft request'  (duration: 118.903227ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:57.848053Z","caller":"traceutil/trace.go:171","msg":"trace[325301396] transaction","detail":"{read_only:false; response_revision:24767; number_of_response:1; }","duration":"110.254853ms","start":"2026-05-09T17:41:57.737755Z","end":"2026-05-09T17:41:57.84801Z","steps":["trace[325301396] 'process raft request'  (duration: 110.022927ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:58.485378Z","caller":"traceutil/trace.go:171","msg":"trace[1676924142] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"288.234948ms","start":"2026-05-09T17:41:58.197118Z","end":"2026-05-09T17:41:58.485353Z","steps":["trace[1676924142] 'process raft request'  (duration: 280.112577ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:58.4857Z","caller":"traceutil/trace.go:171","msg":"trace[2108718739] linearizableReadLoop","detail":"{readStateIndex:25565; appliedIndex:25562; }","duration":"276.286062ms","start":"2026-05-09T17:41:58.209368Z","end":"2026-05-09T17:41:58.485654Z","steps":["trace[2108718739] 'read index received'  (duration: 82.853686ms)","trace[2108718739] 'applied index is now lower than readState.Index'  (duration: 193.430106ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:58.48579Z","caller":"traceutil/trace.go:171","msg":"trace[324730911] transaction","detail":"{read_only:false; response_revision:24771; number_of_response:1; }","duration":"276.393655ms","start":"2026-05-09T17:41:58.209328Z","end":"2026-05-09T17:41:58.485722Z","steps":["trace[324730911] 'process raft request'  (duration: 275.969364ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:58.486151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.744844ms","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-05-09T17:41:58.486223Z","caller":"traceutil/trace.go:171","msg":"trace[1351876971] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24771; }","duration":"276.896539ms","start":"2026-05-09T17:41:58.209302Z","end":"2026-05-09T17:41:58.486199Z","steps":["trace[1351876971] 'agreement among raft nodes before linearized reading'  (duration: 276.528219ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:58.732509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.006415ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882773254 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24758 > 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:18"}
{"level":"info","ts":"2026-05-09T17:41:58.732667Z","caller":"traceutil/trace.go:171","msg":"trace[945495364] transaction","detail":"{read_only:false; response_revision:24772; number_of_response:1; }","duration":"241.511985ms","start":"2026-05-09T17:41:58.49112Z","end":"2026-05-09T17:41:58.732632Z","steps":["trace[945495364] 'process raft request'  (duration: 99.276044ms)","trace[945495364] 'compare'  (duration: 141.780479ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:41:58.732842Z","caller":"traceutil/trace.go:171","msg":"trace[373000128] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"211.22926ms","start":"2026-05-09T17:41:58.521509Z","end":"2026-05-09T17:41:58.732739Z","steps":["trace[373000128] 'process raft request'  (duration: 211.187959ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:58.733117Z","caller":"traceutil/trace.go:171","msg":"trace[369595665] linearizableReadLoop","detail":"{readStateIndex:25566; appliedIndex:25565; }","duration":"214.535432ms","start":"2026-05-09T17:41:58.518568Z","end":"2026-05-09T17:41:58.733104Z","steps":["trace[369595665] 'read index received'  (duration: 71.840797ms)","trace[369595665] 'applied index is now lower than readState.Index'  (duration: 142.693475ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:58.733275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.329575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:58.733321Z","caller":"traceutil/trace.go:171","msg":"trace[1976526870] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:24774; }","duration":"135.448019ms","start":"2026-05-09T17:41:58.597859Z","end":"2026-05-09T17:41:58.733307Z","steps":["trace[1976526870] 'agreement among raft nodes before linearized reading'  (duration: 135.361666ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:58.733345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.741147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-09T17:41:58.733363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.398651ms","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-05-09T17:41:58.7334Z","caller":"traceutil/trace.go:171","msg":"trace[1601825528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24774; }","duration":"214.84499ms","start":"2026-05-09T17:41:58.518542Z","end":"2026-05-09T17:41:58.733387Z","steps":["trace[1601825528] 'agreement among raft nodes before linearized reading'  (duration: 214.667975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:58.7334Z","caller":"traceutil/trace.go:171","msg":"trace[1674069633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24774; }","duration":"213.454213ms","start":"2026-05-09T17:41:58.519937Z","end":"2026-05-09T17:41:58.733392Z","steps":["trace[1674069633] 'agreement among raft nodes before linearized reading'  (duration: 213.315389ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:58.733414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.8408ms","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-05-09T17:41:58.733483Z","caller":"traceutil/trace.go:171","msg":"trace[623883922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24774; }","duration":"214.964103ms","start":"2026-05-09T17:41:58.518504Z","end":"2026-05-09T17:41:58.733468Z","steps":["trace[623883922] 'agreement among raft nodes before linearized reading'  (duration: 214.804919ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:58.733518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.695526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:41:58.733618Z","caller":"traceutil/trace.go:171","msg":"trace[1146435973] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24774; }","duration":"214.822529ms","start":"2026-05-09T17:41:58.51877Z","end":"2026-05-09T17:41:58.733593Z","steps":["trace[1146435973] 'agreement among raft nodes before linearized reading'  (duration: 214.561122ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:58.733306Z","caller":"traceutil/trace.go:171","msg":"trace[840294326] transaction","detail":"{read_only:false; response_revision:24773; number_of_response:1; }","duration":"212.047784ms","start":"2026-05-09T17:41:58.521192Z","end":"2026-05-09T17:41:58.73324Z","steps":["trace[840294326] 'process raft request'  (duration: 211.443827ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:58.906346Z","caller":"traceutil/trace.go:171","msg":"trace[2062451204] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"167.81353ms","start":"2026-05-09T17:41:58.738251Z","end":"2026-05-09T17:41:58.906065Z","steps":["trace[2062451204] 'process raft request'  (duration: 167.614774ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:59.067993Z","caller":"traceutil/trace.go:171","msg":"trace[1890000919] transaction","detail":"{read_only:false; response_revision:24777; number_of_response:1; }","duration":"328.169755ms","start":"2026-05-09T17:41:58.739798Z","end":"2026-05-09T17:41:59.067968Z","steps":["trace[1890000919] 'process raft request'  (duration: 327.659301ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:41:59.068199Z","caller":"traceutil/trace.go:171","msg":"trace[1429824151] transaction","detail":"{read_only:false; response_revision:24778; number_of_response:1; }","duration":"328.34544ms","start":"2026-05-09T17:41:58.739835Z","end":"2026-05-09T17:41:59.06818Z","steps":["trace[1429824151] 'process raft request'  (duration: 327.707022ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:59.068213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:58.739784Z","time spent":"328.267407ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24762 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:59.068278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:58.739809Z","time spent":"328.431612ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24760 > 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-05-09T17:41:59.068443Z","caller":"traceutil/trace.go:171","msg":"trace[1460847146] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"329.006537ms","start":"2026-05-09T17:41:58.739302Z","end":"2026-05-09T17:41:59.068309Z","steps":["trace[1460847146] 'process raft request'  (duration: 326.725845ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:59.068826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:58.739278Z","time spent":"329.341926ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24759 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-09T17:41:59.226341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.706992ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960384882773263 > lease_revoke:<id:16649e0da9eb0bf8>","response":"size:29"}
{"level":"info","ts":"2026-05-09T17:41:59.226469Z","caller":"traceutil/trace.go:171","msg":"trace[1292746147] linearizableReadLoop","detail":"{readStateIndex:25573; appliedIndex:25568; }","duration":"360.312711ms","start":"2026-05-09T17:41:58.866119Z","end":"2026-05-09T17:41:59.226432Z","steps":["trace[1292746147] 'read index received'  (duration: 39.719152ms)","trace[1292746147] 'applied index is now lower than readState.Index'  (duration: 320.591689ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T17:41:59.226869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.715361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T17:41:59.227628Z","caller":"traceutil/trace.go:171","msg":"trace[572727067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24778; }","duration":"361.536084ms","start":"2026-05-09T17:41:58.866066Z","end":"2026-05-09T17:41:59.227603Z","steps":["trace[572727067] 'agreement among raft nodes before linearized reading'  (duration: 360.65243ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:41:59.227696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:58.866046Z","time spent":"361.621136ms","remote":"127.0.0.1:57770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-09T17:42:00.320773Z","caller":"traceutil/trace.go:171","msg":"trace[544623673] transaction","detail":"{read_only:false; response_revision:24781; number_of_response:1; }","duration":"349.845995ms","start":"2026-05-09T17:41:59.970905Z","end":"2026-05-09T17:42:00.320751Z","steps":["trace[544623673] 'process raft request'  (duration: 349.707492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:00.320909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:41:59.970879Z","time spent":"349.963479ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24768 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-09T17:42:00.644741Z","caller":"traceutil/trace.go:171","msg":"trace[1223647576] transaction","detail":"{read_only:false; response_revision:24784; number_of_response:1; }","duration":"152.932464ms","start":"2026-05-09T17:42:00.491768Z","end":"2026-05-09T17:42:00.6447Z","steps":["trace[1223647576] 'process raft request'  (duration: 152.813481ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.644764Z","caller":"traceutil/trace.go:171","msg":"trace[393645376] transaction","detail":"{read_only:false; response_revision:24783; number_of_response:1; }","duration":"155.0355ms","start":"2026-05-09T17:42:00.489674Z","end":"2026-05-09T17:42:00.64471Z","steps":["trace[393645376] 'process raft request'  (duration: 153.125358ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.864277Z","caller":"traceutil/trace.go:171","msg":"trace[732054808] transaction","detail":"{read_only:false; response_revision:24785; number_of_response:1; }","duration":"125.222149ms","start":"2026-05-09T17:42:00.739018Z","end":"2026-05-09T17:42:00.86424Z","steps":["trace[732054808] 'process raft request'  (duration: 121.909419ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.870403Z","caller":"traceutil/trace.go:171","msg":"trace[1689168296] transaction","detail":"{read_only:false; response_revision:24786; number_of_response:1; }","duration":"131.006448ms","start":"2026-05-09T17:42:00.739356Z","end":"2026-05-09T17:42:00.870363Z","steps":["trace[1689168296] 'process raft request'  (duration: 130.709179ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:00.870473Z","caller":"traceutil/trace.go:171","msg":"trace[1313168306] transaction","detail":"{read_only:false; response_revision:24787; number_of_response:1; }","duration":"130.834043ms","start":"2026-05-09T17:42:00.739612Z","end":"2026-05-09T17:42:00.870446Z","steps":["trace[1313168306] 'process raft request'  (duration: 130.553924ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.012883Z","caller":"traceutil/trace.go:171","msg":"trace[843473785] transaction","detail":"{read_only:false; response_revision:24801; number_of_response:1; }","duration":"141.596975ms","start":"2026-05-09T17:42:02.871261Z","end":"2026-05-09T17:42:03.012858Z","steps":["trace[843473785] 'process raft request'  (duration: 141.41916ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.273639Z","caller":"traceutil/trace.go:171","msg":"trace[1665768851] linearizableReadLoop","detail":"{readStateIndex:25598; appliedIndex:25595; }","duration":"397.985735ms","start":"2026-05-09T17:42:02.875634Z","end":"2026-05-09T17:42:03.273619Z","steps":["trace[1665768851] 'read index received'  (duration: 137.01055ms)","trace[1665768851] 'applied index is now lower than readState.Index'  (duration: 260.971745ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:42:03.273691Z","caller":"traceutil/trace.go:171","msg":"trace[850685968] transaction","detail":"{read_only:false; response_revision:24802; number_of_response:1; }","duration":"399.24264ms","start":"2026-05-09T17:42:02.874419Z","end":"2026-05-09T17:42:03.273662Z","steps":["trace[850685968] 'process raft request'  (duration: 399.027604ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.273727Z","caller":"traceutil/trace.go:171","msg":"trace[207230504] transaction","detail":"{read_only:false; response_revision:24803; number_of_response:1; }","duration":"398.706175ms","start":"2026-05-09T17:42:02.874984Z","end":"2026-05-09T17:42:03.27369Z","steps":["trace[207230504] 'process raft request'  (duration: 398.601743ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:03.27381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.141071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T17:42:03.273816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:42:02.874394Z","time spent":"399.351843ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24787 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T17:42:03.273862Z","caller":"traceutil/trace.go:171","msg":"trace[1276841091] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24803; }","duration":"398.240073ms","start":"2026-05-09T17:42:02.875607Z","end":"2026-05-09T17:42:03.273847Z","steps":["trace[1276841091] 'agreement among raft nodes before linearized reading'  (duration: 398.13494ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:03.273904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:42:02.875597Z","time spent":"398.295904ms","remote":"127.0.0.1:52722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T17:42:03.273896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:42:02.874975Z","time spent":"398.827328ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24786 > 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-05-09T17:42:03.273986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.424204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-05-09T17:42:03.274008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.902604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-09T17:42:03.274037Z","caller":"traceutil/trace.go:171","msg":"trace[311698692] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24803; }","duration":"188.953215ms","start":"2026-05-09T17:42:03.085072Z","end":"2026-05-09T17:42:03.274025Z","steps":["trace[311698692] 'agreement among raft nodes before linearized reading'  (duration: 188.844051ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.274051Z","caller":"traceutil/trace.go:171","msg":"trace[2075516967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24803; }","duration":"353.507326ms","start":"2026-05-09T17:42:02.920515Z","end":"2026-05-09T17:42:03.274022Z","steps":["trace[2075516967] 'agreement among raft nodes before linearized reading'  (duration: 353.377892ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T17:42:03.274086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T17:42:02.920495Z","time spent":"353.583158ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T17:42:03.27414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.910115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-09T17:42:03.274151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.754161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-09T17:42:03.274148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.776432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-05-09T17:42:03.274186Z","caller":"traceutil/trace.go:171","msg":"trace[171866548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24803; }","duration":"191.993007ms","start":"2026-05-09T17:42:03.082182Z","end":"2026-05-09T17:42:03.274175Z","steps":["trace[171866548] 'agreement among raft nodes before linearized reading'  (duration: 191.864164ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.274201Z","caller":"traceutil/trace.go:171","msg":"trace[1965283577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24803; }","duration":"191.817523ms","start":"2026-05-09T17:42:03.08237Z","end":"2026-05-09T17:42:03.274187Z","steps":["trace[1965283577] 'agreement among raft nodes before linearized reading'  (duration: 191.627748ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.274239Z","caller":"traceutil/trace.go:171","msg":"trace[119592259] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24803; }","duration":"144.915565ms","start":"2026-05-09T17:42:03.129296Z","end":"2026-05-09T17:42:03.274212Z","steps":["trace[119592259] 'agreement among raft nodes before linearized reading'  (duration: 144.643888ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.464095Z","caller":"traceutil/trace.go:171","msg":"trace[660380935] transaction","detail":"{read_only:false; response_revision:24806; number_of_response:1; }","duration":"184.185724ms","start":"2026-05-09T17:42:03.279892Z","end":"2026-05-09T17:42:03.464078Z","steps":["trace[660380935] 'process raft request'  (duration: 184.128483ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.464364Z","caller":"traceutil/trace.go:171","msg":"trace[108689479] transaction","detail":"{read_only:false; response_revision:24808; number_of_response:1; }","duration":"184.316957ms","start":"2026-05-09T17:42:03.280037Z","end":"2026-05-09T17:42:03.464354Z","steps":["trace[108689479] 'process raft request'  (duration: 184.213655ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.46436Z","caller":"traceutil/trace.go:171","msg":"trace[1194464984] transaction","detail":"{read_only:false; response_revision:24807; number_of_response:1; }","duration":"184.362149ms","start":"2026-05-09T17:42:03.279974Z","end":"2026-05-09T17:42:03.464336Z","steps":["trace[1194464984] 'process raft request'  (duration: 184.074471ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.464555Z","caller":"traceutil/trace.go:171","msg":"trace[1707056985] transaction","detail":"{read_only:false; response_revision:24805; number_of_response:1; }","duration":"184.300128ms","start":"2026-05-09T17:42:03.279838Z","end":"2026-05-09T17:42:03.464138Z","steps":["trace[1707056985] 'process raft request'  (duration: 184.056901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:42:03.580663Z","caller":"traceutil/trace.go:171","msg":"trace[222359129] transaction","detail":"{read_only:false; response_revision:24809; number_of_response:1; }","duration":"111.229469ms","start":"2026-05-09T17:42:03.469403Z","end":"2026-05-09T17:42:03.580632Z","steps":["trace[222359129] 'process raft request'  (duration: 87.236195ms)","trace[222359129] 'compare'  (duration: 23.603954ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T17:42:04.528301Z","caller":"traceutil/trace.go:171","msg":"trace[1250506449] transaction","detail":"{read_only:false; response_revision:24813; number_of_response:1; }","duration":"148.571256ms","start":"2026-05-09T17:42:04.379711Z","end":"2026-05-09T17:42:04.528283Z","steps":["trace[1250506449] 'process raft request'  (duration: 148.448362ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T17:44:52.404513Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006acb.wal"}
{"level":"info","ts":"2026-05-09T17:45:00.26922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23617}
{"level":"info","ts":"2026-05-09T17:45:00.399386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23617,"took":"125.831449ms","hash":189521919,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":37277696,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-05-09T17:45:00.399461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":189521919,"revision":23617,"compact-revision":20417}
{"level":"info","ts":"2026-05-09T17:50:00.278245Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26598}
{"level":"info","ts":"2026-05-09T17:50:00.419868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26598,"took":"137.241248ms","hash":3554366205,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":31764480,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T17:50:00.419944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3554366205,"revision":26598,"compact-revision":23617}
{"level":"info","ts":"2026-05-09T17:50:11.573505Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T17:50:11.5783Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-09T17:50:11.578415Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-09T17:55:00.284203Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28981}
{"level":"info","ts":"2026-05-09T17:55:00.422479Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28981,"took":"133.827316ms","hash":2293948361,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":29716480,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T17:55:00.422542Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2293948361,"revision":28981,"compact-revision":26598}
{"level":"info","ts":"2026-05-09T18:00:00.290455Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31201}
{"level":"info","ts":"2026-05-09T18:00:00.404981Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31201,"took":"111.578929ms","hash":357344217,"current-db-size-bytes":57200640,"current-db-size":"57 MB","current-db-size-in-use-bytes":32104448,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T18:00:00.405127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":357344217,"revision":31201,"compact-revision":28981}
{"level":"info","ts":"2026-05-09T18:05:00.297129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33553}
{"level":"info","ts":"2026-05-09T18:05:00.44955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33553,"took":"148.810202ms","hash":2994230864,"current-db-size-bytes":58245120,"current-db-size":"58 MB","current-db-size-in-use-bytes":32727040,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-09T18:05:00.4496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2994230864,"revision":33553,"compact-revision":31201}
{"level":"info","ts":"2026-05-09T18:10:00.301893Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35839}
{"level":"info","ts":"2026-05-09T18:10:00.437114Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35839,"took":"130.853344ms","hash":4016506521,"current-db-size-bytes":58245120,"current-db-size":"58 MB","current-db-size-in-use-bytes":30183424,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T18:10:00.437175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4016506521,"revision":35839,"compact-revision":33553}