{"level":"warn","ts":"2026-05-21T14:35:17.662451Z","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-21T14:35:17.662575Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-21T14:35:17.662653Z","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-21T14:35:17.662666Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]}
{"level":"info","ts":"2026-05-21T14:35:17.662687Z","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-21T14:35:17.663333Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]}
{"level":"info","ts":"2026-05-21T14:35:17.663406Z","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-21T14:35:17.66722Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.603313ms"}
{"level":"info","ts":"2026-05-21T14:35:17.67483Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"}
{"level":"info","ts":"2026-05-21T14:35:17.67491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-21T14:35:17.674938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"}
{"level":"info","ts":"2026-05-21T14:35:17.674953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-21T14:35:17.674962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"}
{"level":"info","ts":"2026-05-21T14:35:17.675001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"}
{"level":"warn","ts":"2026-05-21T14:35:17.683239Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-21T14:35:17.68468Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-21T14:35:17.686758Z","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-21T14:35:17.689384Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-21T14:35:17.690103Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-21T14:35:17.690375Z","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-21T14:35:17.691958Z","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-21T14:35:17.691981Z","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-21T14:35:17.692432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"}
{"level":"info","ts":"2026-05-21T14:35:17.692613Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]}
{"level":"info","ts":"2026-05-21T14:35:17.694572Z","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-21T14:35:17.694673Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"}
{"level":"info","ts":"2026-05-21T14:35:17.694728Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"}
{"level":"info","ts":"2026-05-21T14:35:17.695314Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-21T14:35:17.695381Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-21T14:35:18.275348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-21T14:35:18.27541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-21T14:35:18.27545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"}
{"level":"info","ts":"2026-05-21T14:35:18.275465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"}
{"level":"info","ts":"2026-05-21T14:35:18.275477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"}
{"level":"info","ts":"2026-05-21T14:35:18.275488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"}
{"level":"info","ts":"2026-05-21T14:35:18.275502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"}
{"level":"info","ts":"2026-05-21T14:35:18.277276Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T14:35:18.278183Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-21T14:35:18.278233Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-21T14:35:18.278322Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-21T14:35:18.278594Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-21T14:35:18.278668Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-21T14:35:18.278825Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T14:35:18.279093Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T14:35:18.279178Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T14:35:18.281394Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-21T14:35:18.283575Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"}
{"level":"info","ts":"2026-05-21T14:35:37.075844Z","caller":"traceutil/trace.go:171","msg":"trace[1258727611] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"161.543106ms","start":"2026-05-21T14:35:36.914271Z","end":"2026-05-21T14:35:37.075814Z","steps":["trace[1258727611] 'process raft request'  (duration: 161.34345ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:36:00.182405Z","caller":"traceutil/trace.go:171","msg":"trace[194422593] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"199.521639ms","start":"2026-05-21T14:35:59.982853Z","end":"2026-05-21T14:36:00.182375Z","steps":["trace[194422593] 'process raft request'  (duration: 197.882882ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:36:00.67584Z","caller":"traceutil/trace.go:171","msg":"trace[546999726] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"373.740208ms","start":"2026-05-21T14:36:00.302075Z","end":"2026-05-21T14:36:00.675816Z","steps":["trace[546999726] 'process raft request'  (duration: 330.822925ms)","trace[546999726] 'compare'  (duration: 42.77716ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T14:36:00.676307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:36:00.302056Z","time spent":"373.847461ms","remote":"127.0.0.1:38692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dx6wp\" mod_revision:477 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dx6wp\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dx6wp\" > >"}
{"level":"info","ts":"2026-05-21T14:36:01.171633Z","caller":"traceutil/trace.go:171","msg":"trace[1914910120] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"465.204046ms","start":"2026-05-21T14:36:00.706394Z","end":"2026-05-21T14:36:01.171598Z","steps":["trace[1914910120] 'process raft request'  (duration: 463.925899ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:36:01.172516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:36:00.706361Z","time spent":"465.430491ms","remote":"127.0.0.1:38622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:588 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036209 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-21T14:36:01.178851Z","caller":"traceutil/trace.go:171","msg":"trace[386832363] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"246.605932ms","start":"2026-05-21T14:36:00.932204Z","end":"2026-05-21T14:36:01.17881Z","steps":["trace[386832363] 'process raft request'  (duration: 246.426047ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:36:16.960465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.653595ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392816488 > lease_revoke:<id:47859e4af6533033>","response":"size:28"}
{"level":"info","ts":"2026-05-21T14:37:02.714262Z","caller":"traceutil/trace.go:171","msg":"trace[328590113] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"103.840862ms","start":"2026-05-21T14:37:02.610392Z","end":"2026-05-21T14:37:02.714232Z","steps":["trace[328590113] 'process raft request'  (duration: 102.439212ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:37:02.714266Z","caller":"traceutil/trace.go:171","msg":"trace[1632100851] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"100.831196ms","start":"2026-05-21T14:37:02.613401Z","end":"2026-05-21T14:37:02.714232Z","steps":["trace[1632100851] 'read index received'  (duration: 99.407215ms)","trace[1632100851] 'applied index is now lower than readState.Index'  (duration: 1.422861ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T14:37:02.714704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.3021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-21T14:37:02.714796Z","caller":"traceutil/trace.go:171","msg":"trace[583250038] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"101.446424ms","start":"2026-05-21T14:37:02.613327Z","end":"2026-05-21T14:37:02.714773Z","steps":["trace[583250038] 'agreement among raft nodes before linearized reading'  (duration: 100.948289ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:37:33.067999Z","caller":"traceutil/trace.go:171","msg":"trace[1713831183] linearizableReadLoop","detail":"{readStateIndex:1898; appliedIndex:1897; }","duration":"211.833097ms","start":"2026-05-21T14:37:32.856128Z","end":"2026-05-21T14:37:33.067961Z","steps":["trace[1713831183] 'read index received'  (duration: 211.782815ms)","trace[1713831183] 'applied index is now lower than readState.Index'  (duration: 48.782µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:37:33.068117Z","caller":"traceutil/trace.go:171","msg":"trace[435522044] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"256.068192ms","start":"2026-05-21T14:37:32.812012Z","end":"2026-05-21T14:37:33.06808Z","steps":["trace[435522044] 'process raft request'  (duration: 255.802394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:37:33.068383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.199687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-21T14:37:33.068479Z","caller":"traceutil/trace.go:171","msg":"trace[699154884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1829; }","duration":"212.382272ms","start":"2026-05-21T14:37:32.856076Z","end":"2026-05-21T14:37:33.068458Z","steps":["trace[699154884] 'agreement among raft nodes before linearized reading'  (duration: 212.052093ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:37:33.155469Z","caller":"traceutil/trace.go:171","msg":"trace[2137091630] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"161.182861ms","start":"2026-05-21T14:37:32.994253Z","end":"2026-05-21T14:37:33.155435Z","steps":["trace[2137091630] 'process raft request'  (duration: 161.069667ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:37:33.155622Z","caller":"traceutil/trace.go:171","msg":"trace[1061161870] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"285.808224ms","start":"2026-05-21T14:37:32.869777Z","end":"2026-05-21T14:37:33.155585Z","steps":["trace[1061161870] 'process raft request'  (duration: 285.382732ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:37:33.155638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.125248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-21T14:37:33.155887Z","caller":"traceutil/trace.go:171","msg":"trace[1503837789] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1831; }","duration":"295.391595ms","start":"2026-05-21T14:37:32.860424Z","end":"2026-05-21T14:37:33.155815Z","steps":["trace[1503837789] 'agreement among raft nodes before linearized reading'  (duration: 294.957963ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:37:33.156396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.542213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02323b12-b32b-4cb2-a4fc-afc0bb6f89dc\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-05-21T14:37:33.156462Z","caller":"traceutil/trace.go:171","msg":"trace[1278625395] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-02323b12-b32b-4cb2-a4fc-afc0bb6f89dc; range_end:; response_count:1; response_revision:1831; }","duration":"251.643286ms","start":"2026-05-21T14:37:32.904802Z","end":"2026-05-21T14:37:33.156446Z","steps":["trace[1278625395] 'agreement among raft nodes before linearized reading'  (duration: 250.800872ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:37:33.424686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.297862ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392818559 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1783 > 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:16"}
{"level":"info","ts":"2026-05-21T14:37:33.424794Z","caller":"traceutil/trace.go:171","msg":"trace[785046027] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"264.517779ms","start":"2026-05-21T14:37:33.160257Z","end":"2026-05-21T14:37:33.424775Z","steps":["trace[785046027] 'read index received'  (duration: 28.967131ms)","trace[785046027] 'applied index is now lower than readState.Index'  (duration: 235.549128ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:37:33.425023Z","caller":"traceutil/trace.go:171","msg":"trace[828495693] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"351.893757ms","start":"2026-05-21T14:37:33.073115Z","end":"2026-05-21T14:37:33.425009Z","steps":["trace[828495693] 'process raft request'  (duration: 116.140833ms)","trace[828495693] 'compare'  (duration: 235.167727ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T14:37:33.425198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:37:33.073093Z","time spent":"351.973149ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1783 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-21T14:37:33.425275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.990883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"}
{"level":"info","ts":"2026-05-21T14:37:33.42535Z","caller":"traceutil/trace.go:171","msg":"trace[157136643] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1832; }","duration":"265.120627ms","start":"2026-05-21T14:37:33.160212Z","end":"2026-05-21T14:37:33.425333Z","steps":["trace[157136643] 'agreement among raft nodes before linearized reading'  (duration: 264.86513ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:37:33.45041Z","caller":"traceutil/trace.go:171","msg":"trace[1930259484] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"288.173731ms","start":"2026-05-21T14:37:33.162201Z","end":"2026-05-21T14:37:33.450375Z","steps":["trace[1930259484] 'process raft request'  (duration: 287.816461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:37:33.45069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.975786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-21T14:37:33.450714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.035366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T14:37:33.45074Z","caller":"traceutil/trace.go:171","msg":"trace[524566061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1833; }","duration":"154.061369ms","start":"2026-05-21T14:37:33.296666Z","end":"2026-05-21T14:37:33.450727Z","steps":["trace[524566061] 'agreement among raft nodes before linearized reading'  (duration: 153.971266ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:37:33.45078Z","caller":"traceutil/trace.go:171","msg":"trace[1262364110] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1833; }","duration":"258.160249ms","start":"2026-05-21T14:37:33.192588Z","end":"2026-05-21T14:37:33.450748Z","steps":["trace[1262364110] 'agreement among raft nodes before linearized reading'  (duration: 258.040246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:37:33.450835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.048016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-21T14:37:33.450901Z","caller":"traceutil/trace.go:171","msg":"trace[1566537357] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1833; }","duration":"210.139668ms","start":"2026-05-21T14:37:33.240741Z","end":"2026-05-21T14:37:33.450881Z","steps":["trace[1566537357] 'agreement among raft nodes before linearized reading'  (duration: 209.922982ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:38:24.019398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.91076ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392819311 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2149 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T14:38:24.019589Z","caller":"traceutil/trace.go:171","msg":"trace[292860755] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"200.419531ms","start":"2026-05-21T14:38:23.819115Z","end":"2026-05-21T14:38:24.019534Z","steps":["trace[292860755] 'process raft request'  (duration: 91.270834ms)","trace[292860755] 'compare'  (duration: 108.709574ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:39:46.003018Z","caller":"traceutil/trace.go:171","msg":"trace[2018083061] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"121.958597ms","start":"2026-05-21T14:39:45.881035Z","end":"2026-05-21T14:39:46.002994Z","steps":["trace[2018083061] 'process raft request'  (duration: 121.486744ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:42:11.896717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.557517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8xhf7\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-21T14:42:11.89681Z","caller":"traceutil/trace.go:171","msg":"trace[735833497] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8xhf7; range_end:; response_count:1; response_revision:3769; }","duration":"129.685881ms","start":"2026-05-21T14:42:11.767105Z","end":"2026-05-21T14:42:11.896791Z","steps":["trace[735833497] 'range keys from in-memory index tree'  (duration: 129.406913ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:42:11.89696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.548222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T14:42:11.897106Z","caller":"traceutil/trace.go:171","msg":"trace[1489612697] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:3769; }","duration":"145.739547ms","start":"2026-05-21T14:42:11.751341Z","end":"2026-05-21T14:42:11.897081Z","steps":["trace[1489612697] 'count revisions from in-memory index tree'  (duration: 145.400278ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:37.227339Z","caller":"traceutil/trace.go:171","msg":"trace[2108910716] linearizableReadLoop","detail":"{readStateIndex:5003; appliedIndex:5002; }","duration":"255.711796ms","start":"2026-05-21T14:43:36.971597Z","end":"2026-05-21T14:43:37.227309Z","steps":["trace[2108910716] 'read index received'  (duration: 255.440548ms)","trace[2108910716] 'applied index is now lower than readState.Index'  (duration: 270.327µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:43:37.22753Z","caller":"traceutil/trace.go:171","msg":"trace[1688736687] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"261.090854ms","start":"2026-05-21T14:43:36.966396Z","end":"2026-05-21T14:43:37.227486Z","steps":["trace[1688736687] 'process raft request'  (duration: 260.736755ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.227893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.538658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-21T14:43:37.22796Z","caller":"traceutil/trace.go:171","msg":"trace[1756067460] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4818; }","duration":"230.655842ms","start":"2026-05-21T14:43:36.997288Z","end":"2026-05-21T14:43:37.227944Z","steps":["trace[1756067460] 'agreement among raft nodes before linearized reading'  (duration: 230.303042ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.22806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.263424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:531232"}
{"level":"info","ts":"2026-05-21T14:43:37.228199Z","caller":"traceutil/trace.go:171","msg":"trace[1230852681] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4818; }","duration":"100.430948ms","start":"2026-05-21T14:43:37.127701Z","end":"2026-05-21T14:43:37.228131Z","steps":["trace[1230852681] 'agreement among raft nodes before linearized reading'  (duration: 99.896353ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.228799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.162306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-05-21T14:43:37.22892Z","caller":"traceutil/trace.go:171","msg":"trace[774876774] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4818; }","duration":"257.31095ms","start":"2026-05-21T14:43:36.971583Z","end":"2026-05-21T14:43:37.228894Z","steps":["trace[774876774] 'agreement among raft nodes before linearized reading'  (duration: 255.915561ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:37.491823Z","caller":"traceutil/trace.go:171","msg":"trace[594437317] linearizableReadLoop","detail":"{readStateIndex:5005; appliedIndex:5004; }","duration":"219.021541ms","start":"2026-05-21T14:43:37.272771Z","end":"2026-05-21T14:43:37.491792Z","steps":["trace[594437317] 'read index received'  (duration: 218.881157ms)","trace[594437317] 'applied index is now lower than readState.Index'  (duration: 139.264µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:43:37.491879Z","caller":"traceutil/trace.go:171","msg":"trace[1205167799] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"258.205136ms","start":"2026-05-21T14:43:37.233637Z","end":"2026-05-21T14:43:37.491842Z","steps":["trace[1205167799] 'process raft request'  (duration: 257.946919ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.492082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.403094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14497"}
{"level":"info","ts":"2026-05-21T14:43:37.492199Z","caller":"traceutil/trace.go:171","msg":"trace[1909058810] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4820; }","duration":"252.490596ms","start":"2026-05-21T14:43:37.239627Z","end":"2026-05-21T14:43:37.492117Z","steps":["trace[1909058810] 'agreement among raft nodes before linearized reading'  (duration: 252.290261ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.492264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.561474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:531232"}
{"level":"info","ts":"2026-05-21T14:43:37.492316Z","caller":"traceutil/trace.go:171","msg":"trace[1804194026] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4820; }","duration":"232.628906ms","start":"2026-05-21T14:43:37.259677Z","end":"2026-05-21T14:43:37.492306Z","steps":["trace[1804194026] 'agreement among raft nodes before linearized reading'  (duration: 232.171454ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:37.51904Z","caller":"traceutil/trace.go:171","msg":"trace[959348487] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"170.493408ms","start":"2026-05-21T14:43:37.348515Z","end":"2026-05-21T14:43:37.519008Z","steps":["trace[959348487] 'process raft request'  (duration: 170.180439ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.519133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.792542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"warn","ts":"2026-05-21T14:43:37.519127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.121359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-05-21T14:43:37.519212Z","caller":"traceutil/trace.go:171","msg":"trace[1217373888] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4821; }","duration":"197.892945ms","start":"2026-05-21T14:43:37.321292Z","end":"2026-05-21T14:43:37.519185Z","steps":["trace[1217373888] 'agreement among raft nodes before linearized reading'  (duration: 197.675439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:37.519216Z","caller":"traceutil/trace.go:171","msg":"trace[1086267626] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4821; }","duration":"242.266563ms","start":"2026-05-21T14:43:37.276929Z","end":"2026-05-21T14:43:37.519195Z","steps":["trace[1086267626] 'agreement among raft nodes before linearized reading'  (duration: 241.936184ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:37.656625Z","caller":"traceutil/trace.go:171","msg":"trace[162925528] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"133.02514ms","start":"2026-05-21T14:43:37.52355Z","end":"2026-05-21T14:43:37.656575Z","steps":["trace[162925528] 'process raft request'  (duration: 132.732582ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:43:37.657174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.120872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T14:43:37.657275Z","caller":"traceutil/trace.go:171","msg":"trace[1371573203] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4825; }","duration":"134.233625ms","start":"2026-05-21T14:43:37.523017Z","end":"2026-05-21T14:43:37.65725Z","steps":["trace[1371573203] 'agreement among raft nodes before linearized reading'  (duration: 134.028749ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:40.892974Z","caller":"traceutil/trace.go:171","msg":"trace[2140751889] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"161.157059ms","start":"2026-05-21T14:43:40.731777Z","end":"2026-05-21T14:43:40.892934Z","steps":["trace[2140751889] 'process raft request'  (duration: 160.967144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:55.18314Z","caller":"traceutil/trace.go:171","msg":"trace[719725956] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"257.435074ms","start":"2026-05-21T14:43:54.925684Z","end":"2026-05-21T14:43:55.183119Z","steps":["trace[719725956] 'process raft request'  (duration: 257.213118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:55.18351Z","caller":"traceutil/trace.go:171","msg":"trace[761939326] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"255.756057ms","start":"2026-05-21T14:43:54.927725Z","end":"2026-05-21T14:43:55.183481Z","steps":["trace[761939326] 'process raft request'  (duration: 255.335245ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:55.183804Z","caller":"traceutil/trace.go:171","msg":"trace[748079883] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"255.865159ms","start":"2026-05-21T14:43:54.927887Z","end":"2026-05-21T14:43:55.183752Z","steps":["trace[748079883] 'process raft request'  (duration: 255.441568ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:43:55.183901Z","caller":"traceutil/trace.go:171","msg":"trace[1771808709] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"247.529719ms","start":"2026-05-21T14:43:54.936346Z","end":"2026-05-21T14:43:55.183875Z","steps":["trace[1771808709] 'process raft request'  (duration: 247.252641ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:45:18.307027Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2974}
{"level":"info","ts":"2026-05-21T14:45:18.374657Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2974,"took":"66.227923ms","hash":2462883536,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":34181120,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-21T14:45:18.374738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2462883536,"revision":2974,"compact-revision":-1}
{"level":"info","ts":"2026-05-21T14:50:10.095921Z","caller":"traceutil/trace.go:171","msg":"trace[1852508225] transaction","detail":"{read_only:false; response_revision:8226; number_of_response:1; }","duration":"252.458794ms","start":"2026-05-21T14:50:09.843432Z","end":"2026-05-21T14:50:10.095891Z","steps":["trace[1852508225] 'process raft request'  (duration: 252.213668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:50:10.279082Z","caller":"traceutil/trace.go:171","msg":"trace[304697478] linearizableReadLoop","detail":"{readStateIndex:8514; appliedIndex:8512; }","duration":"239.453156ms","start":"2026-05-21T14:50:10.039605Z","end":"2026-05-21T14:50:10.279059Z","steps":["trace[304697478] 'read index received'  (duration: 56.037084ms)","trace[304697478] 'applied index is now lower than readState.Index'  (duration: 183.414942ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:50:10.27916Z","caller":"traceutil/trace.go:171","msg":"trace[1854381505] transaction","detail":"{read_only:false; response_revision:8227; number_of_response:1; }","duration":"351.300846ms","start":"2026-05-21T14:50:09.927823Z","end":"2026-05-21T14:50:10.279124Z","steps":["trace[1854381505] 'process raft request'  (duration: 351.131602ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:50:10.279288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.413167ms","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-21T14:50:10.279269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.63314ms","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:7"}
{"level":"warn","ts":"2026-05-21T14:50:10.279328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:09.927787Z","time spent":"351.44527ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8216 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-21T14:50:10.279355Z","caller":"traceutil/trace.go:171","msg":"trace[293628195] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8227; }","duration":"239.780654ms","start":"2026-05-21T14:50:10.039554Z","end":"2026-05-21T14:50:10.279335Z","steps":["trace[293628195] 'agreement among raft nodes before linearized reading'  (duration: 239.61975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:50:10.279317Z","caller":"traceutil/trace.go:171","msg":"trace[155520599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8227; }","duration":"132.499409ms","start":"2026-05-21T14:50:10.146809Z","end":"2026-05-21T14:50:10.279309Z","steps":["trace[155520599] 'agreement among raft nodes before linearized reading'  (duration: 132.369966ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:50:10.279764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.704976ms","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-21T14:50:10.279833Z","caller":"traceutil/trace.go:171","msg":"trace[1066946151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8227; }","duration":"132.791658ms","start":"2026-05-21T14:50:10.147023Z","end":"2026-05-21T14:50:10.279815Z","steps":["trace[1066946151] 'agreement among raft nodes before linearized reading'  (duration: 132.228742ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:50:18.313889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6080}
{"level":"info","ts":"2026-05-21T14:50:18.414948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6080,"took":"99.259335ms","hash":3288549880,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":23793664,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-21T14:50:18.415026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3288549880,"revision":6080,"compact-revision":2974}
{"level":"warn","ts":"2026-05-21T14:50:21.419104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.097685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T14:50:21.419244Z","caller":"traceutil/trace.go:171","msg":"trace[1200792670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8286; }","duration":"121.310591ms","start":"2026-05-21T14:50:21.297913Z","end":"2026-05-21T14:50:21.419223Z","steps":["trace[1200792670] 'range keys from in-memory index tree'  (duration: 120.984552ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:50:50.183749Z","caller":"traceutil/trace.go:171","msg":"trace[1959935091] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"389.236981ms","start":"2026-05-21T14:50:49.794487Z","end":"2026-05-21T14:50:50.183724Z","steps":["trace[1959935091] 'process raft request'  (duration: 389.102607ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:50:50.183907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:49.794471Z","time spent":"389.362815ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8481 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-21T14:50:50.185332Z","caller":"traceutil/trace.go:171","msg":"trace[1521838065] linearizableReadLoop","detail":"{readStateIndex:8790; appliedIndex:8788; }","duration":"389.301004ms","start":"2026-05-21T14:50:49.795981Z","end":"2026-05-21T14:50:50.185282Z","steps":["trace[1521838065] 'read index received'  (duration: 387.666288ms)","trace[1521838065] 'applied index is now lower than readState.Index'  (duration: 1.633466ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:50:50.185401Z","caller":"traceutil/trace.go:171","msg":"trace[1637372364] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"389.54461ms","start":"2026-05-21T14:50:49.795837Z","end":"2026-05-21T14:50:50.185382Z","steps":["trace[1637372364] 'process raft request'  (duration: 389.240701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:50:50.185486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:49.795801Z","time spent":"389.643874ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8482 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-21T14:50:50.185709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.443686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-784778b55b-xv4mn.18b19c228399ac9a\" ","response":"range_response_count:1 size:1135"}
{"level":"warn","ts":"2026-05-21T14:50:50.185719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.54305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-21T14:50:50.185726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.732085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-21T14:50:50.185782Z","caller":"traceutil/trace.go:171","msg":"trace[1700578308] range","detail":"{range_begin:/registry/events/openstack/barbican-api-784778b55b-xv4mn.18b19c228399ac9a; range_end:; response_count:1; response_revision:8492; }","duration":"345.639322ms","start":"2026-05-21T14:50:49.840128Z","end":"2026-05-21T14:50:50.185767Z","steps":["trace[1700578308] 'agreement among raft nodes before linearized reading'  (duration: 345.370165ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:50:50.185807Z","caller":"traceutil/trace.go:171","msg":"trace[488275270] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:8492; }","duration":"336.675333ms","start":"2026-05-21T14:50:49.849113Z","end":"2026-05-21T14:50:50.185788Z","steps":["trace[488275270] 'agreement among raft nodes before linearized reading'  (duration: 336.461188ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:50:50.185817Z","caller":"traceutil/trace.go:171","msg":"trace[1469718635] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8492; }","duration":"389.867029ms","start":"2026-05-21T14:50:49.795933Z","end":"2026-05-21T14:50:50.1858Z","steps":["trace[1469718635] 'agreement among raft nodes before linearized reading'  (duration: 389.54777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T14:50:50.185859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:49.840095Z","time spent":"345.752195ms","remote":"127.0.0.1:38612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-784778b55b-xv4mn.18b19c228399ac9a\" "}
{"level":"warn","ts":"2026-05-21T14:50:50.185923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:49.795923Z","time spent":"389.988592ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-21T14:50:50.185861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T14:50:49.849103Z","time spent":"336.747675ms","remote":"127.0.0.1:60426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "}
{"level":"info","ts":"2026-05-21T14:51:02.553999Z","caller":"traceutil/trace.go:171","msg":"trace[1063220589] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"216.141354ms","start":"2026-05-21T14:51:02.337818Z","end":"2026-05-21T14:51:02.553959Z","steps":["trace[1063220589] 'process raft request'  (duration: 194.96334ms)","trace[1063220589] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:459; } (duration: 20.908016ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:51:02.553996Z","caller":"traceutil/trace.go:171","msg":"trace[1481913962] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"215.657371ms","start":"2026-05-21T14:51:02.338303Z","end":"2026-05-21T14:51:02.55396Z","steps":["trace[1481913962] 'process raft request'  (duration: 215.544558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:51:03.157988Z","caller":"traceutil/trace.go:171","msg":"trace[376163403] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"107.144761ms","start":"2026-05-21T14:51:03.050811Z","end":"2026-05-21T14:51:03.157956Z","steps":["trace[376163403] 'process raft request'  (duration: 106.912185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:51:03.414869Z","caller":"traceutil/trace.go:171","msg":"trace[1706015017] linearizableReadLoop","detail":"{readStateIndex:8914; appliedIndex:8913; }","duration":"128.066788ms","start":"2026-05-21T14:51:03.286771Z","end":"2026-05-21T14:51:03.414837Z","steps":["trace[1706015017] 'read index received'  (duration: 60.2457ms)","trace[1706015017] 'applied index is now lower than readState.Index'  (duration: 67.819407ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T14:51:03.415132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.338766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T14:51:03.415206Z","caller":"traceutil/trace.go:171","msg":"trace[108080219] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8609; }","duration":"128.464878ms","start":"2026-05-21T14:51:03.286723Z","end":"2026-05-21T14:51:03.415188Z","steps":["trace[108080219] 'agreement among raft nodes before linearized reading'  (duration: 128.227372ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:51:03.415367Z","caller":"traceutil/trace.go:171","msg":"trace[198240912] transaction","detail":"{read_only:false; response_revision:8609; number_of_response:1; }","duration":"134.583297ms","start":"2026-05-21T14:51:03.280738Z","end":"2026-05-21T14:51:03.415322Z","steps":["trace[198240912] 'process raft request'  (duration: 66.267235ms)","trace[198240912] 'compare'  (duration: 67.693355ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T14:51:03.550389Z","caller":"traceutil/trace.go:171","msg":"trace[1361727779] linearizableReadLoop","detail":"{readStateIndex:8916; appliedIndex:8914; }","duration":"131.255434ms","start":"2026-05-21T14:51:03.419095Z","end":"2026-05-21T14:51:03.550351Z","steps":["trace[1361727779] 'read index received'  (duration: 7.538437ms)","trace[1361727779] 'applied index is now lower than readState.Index'  (duration: 123.715437ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T14:51:03.550637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.496441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T14:51:03.550686Z","caller":"traceutil/trace.go:171","msg":"trace[1726495042] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8611; }","duration":"131.634106ms","start":"2026-05-21T14:51:03.419038Z","end":"2026-05-21T14:51:03.550672Z","steps":["trace[1726495042] 'agreement among raft nodes before linearized reading'  (duration: 131.45814ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:51:03.5512Z","caller":"traceutil/trace.go:171","msg":"trace[1691369600] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"157.580811ms","start":"2026-05-21T14:51:03.393593Z","end":"2026-05-21T14:51:03.551174Z","steps":["trace[1691369600] 'process raft request'  (duration: 156.524062ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T14:51:18.889741Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000235f.wal"}
{"level":"info","ts":"2026-05-21T14:53:01.965709Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-21T14:53:02.002379Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-21T14:53:02.002495Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-21T14:55:18.321895Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8270}
{"level":"info","ts":"2026-05-21T14:55:18.408262Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8270,"took":"81.725426ms","hash":1993831558,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":25427968,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-21T14:55:18.408333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1993831558,"revision":8270,"compact-revision":6080}
{"level":"info","ts":"2026-05-21T15:00:18.327918Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10755}
{"level":"info","ts":"2026-05-21T15:00:18.40797Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10755,"took":"77.040298ms","hash":2051550702,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":27451392,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-21T15:00:18.408026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2051550702,"revision":10755,"compact-revision":8270}
{"level":"info","ts":"2026-05-21T15:02:34.306685Z","caller":"traceutil/trace.go:171","msg":"trace[1879052723] transaction","detail":"{read_only:false; response_revision:13809; number_of_response:1; }","duration":"116.472962ms","start":"2026-05-21T15:02:34.190178Z","end":"2026-05-21T15:02:34.306651Z","steps":["trace[1879052723] 'process raft request'  (duration: 116.318058ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:02:42.658696Z","caller":"traceutil/trace.go:171","msg":"trace[297574530] transaction","detail":"{read_only:false; response_revision:13867; number_of_response:1; }","duration":"364.462358ms","start":"2026-05-21T15:02:42.294212Z","end":"2026-05-21T15:02:42.658675Z","steps":["trace[297574530] 'process raft request'  (duration: 364.329035ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:02:42.658865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:02:42.294183Z","time spent":"364.597192ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:13839 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-21T15:02:42.663627Z","caller":"traceutil/trace.go:171","msg":"trace[486487943] linearizableReadLoop","detail":"{readStateIndex:14343; appliedIndex:14341; }","duration":"236.163481ms","start":"2026-05-21T15:02:42.427427Z","end":"2026-05-21T15:02:42.663591Z","steps":["trace[486487943] 'read index received'  (duration: 231.04533ms)","trace[486487943] 'applied index is now lower than readState.Index'  (duration: 5.116581ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:02:42.663771Z","caller":"traceutil/trace.go:171","msg":"trace[1430287008] transaction","detail":"{read_only:false; response_revision:13868; number_of_response:1; }","duration":"326.463013ms","start":"2026-05-21T15:02:42.337279Z","end":"2026-05-21T15:02:42.663742Z","steps":["trace[1430287008] 'process raft request'  (duration: 326.138824ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:02:42.663954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.034384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-21T15:02:42.663959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.495511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8xhf7\" ","response":"range_response_count:1 size:6530"}
{"level":"warn","ts":"2026-05-21T15:02:42.664009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:02:42.337258Z","time spent":"326.608987ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:13840 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-21T15:02:42.664015Z","caller":"traceutil/trace.go:171","msg":"trace[1333510725] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13868; }","duration":"182.151677ms","start":"2026-05-21T15:02:42.481845Z","end":"2026-05-21T15:02:42.663997Z","steps":["trace[1333510725] 'agreement among raft nodes before linearized reading'  (duration: 181.986612ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:02:42.664026Z","caller":"traceutil/trace.go:171","msg":"trace[726633368] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8xhf7; range_end:; response_count:1; response_revision:13868; }","duration":"236.625264ms","start":"2026-05-21T15:02:42.427383Z","end":"2026-05-21T15:02:42.664008Z","steps":["trace[726633368] 'agreement among raft nodes before linearized reading'  (duration: 236.378548ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:02:42.664126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.040021ms","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-21T15:02:42.664182Z","caller":"traceutil/trace.go:171","msg":"trace[1511543820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13868; }","duration":"179.154325ms","start":"2026-05-21T15:02:42.485016Z","end":"2026-05-21T15:02:42.66417Z","steps":["trace[1511543820] 'agreement among raft nodes before linearized reading'  (duration: 178.98751ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:02:42.66429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.502236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-05-21T15:02:42.664314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.352907ms","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-21T15:02:42.664356Z","caller":"traceutil/trace.go:171","msg":"trace[334233072] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13868; }","duration":"174.590969ms","start":"2026-05-21T15:02:42.489746Z","end":"2026-05-21T15:02:42.664337Z","steps":["trace[334233072] 'agreement among raft nodes before linearized reading'  (duration: 174.356763ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:02:42.664416Z","caller":"traceutil/trace.go:171","msg":"trace[63575205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13868; }","duration":"180.526262ms","start":"2026-05-21T15:02:42.483868Z","end":"2026-05-21T15:02:42.664394Z","steps":["trace[63575205] 'agreement among raft nodes before linearized reading'  (duration: 180.180042ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:03:04.981084Z","caller":"traceutil/trace.go:171","msg":"trace[170769840] transaction","detail":"{read_only:false; response_revision:14177; number_of_response:1; }","duration":"241.819258ms","start":"2026-05-21T15:03:04.73924Z","end":"2026-05-21T15:03:04.98106Z","steps":["trace[170769840] 'process raft request'  (duration: 241.675554ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:03:05.031972Z","caller":"traceutil/trace.go:171","msg":"trace[799389959] linearizableReadLoop","detail":"{readStateIndex:14664; appliedIndex:14662; }","duration":"256.030238ms","start":"2026-05-21T15:03:04.775907Z","end":"2026-05-21T15:03:05.031938Z","steps":["trace[799389959] 'read index received'  (duration: 205.065368ms)","trace[799389959] 'applied index is now lower than readState.Index'  (duration: 50.96309ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:03:05.032638Z","caller":"traceutil/trace.go:171","msg":"trace[1277009432] transaction","detail":"{read_only:false; response_revision:14178; number_of_response:1; }","duration":"293.133668ms","start":"2026-05-21T15:03:04.739463Z","end":"2026-05-21T15:03:05.032597Z","steps":["trace[1277009432] 'process raft request'  (duration: 292.235224ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:03:05.033074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.270075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c9f1cc8e-cc71-467f-ad74-451788c3ee9b\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-05-21T15:03:05.033129Z","caller":"traceutil/trace.go:171","msg":"trace[590276469] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c9f1cc8e-cc71-467f-ad74-451788c3ee9b; range_end:; response_count:1; response_revision:14178; }","duration":"224.394708ms","start":"2026-05-21T15:03:04.808719Z","end":"2026-05-21T15:03:05.033114Z","steps":["trace[590276469] 'agreement among raft nodes before linearized reading'  (duration: 224.179622ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:03:05.03316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.295477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-21T15:03:05.033228Z","caller":"traceutil/trace.go:171","msg":"trace[531203717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14178; }","duration":"195.508444ms","start":"2026-05-21T15:03:04.837701Z","end":"2026-05-21T15:03:05.03321Z","steps":["trace[531203717] 'agreement among raft nodes before linearized reading'  (duration: 195.266767ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:03:05.033272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.627147ms","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-21T15:03:05.033337Z","caller":"traceutil/trace.go:171","msg":"trace[1916351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14178; }","duration":"195.711369ms","start":"2026-05-21T15:03:04.837609Z","end":"2026-05-21T15:03:05.03332Z","steps":["trace[1916351] 'agreement among raft nodes before linearized reading'  (duration: 195.556625ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:03:05.03338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.920714ms","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-21T15:03:05.033429Z","caller":"traceutil/trace.go:171","msg":"trace[940504392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14178; }","duration":"204.003247ms","start":"2026-05-21T15:03:04.829418Z","end":"2026-05-21T15:03:05.033422Z","steps":["trace[940504392] 'agreement among raft nodes before linearized reading'  (duration: 203.901274ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:03:05.033488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.57746ms","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-21T15:03:05.033537Z","caller":"traceutil/trace.go:171","msg":"trace[1348708772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14178; }","duration":"257.661392ms","start":"2026-05-21T15:03:04.775865Z","end":"2026-05-21T15:03:05.033526Z","steps":["trace[1348708772] 'agreement among raft nodes before linearized reading'  (duration: 257.542159ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:03:05.03371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.133444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8xhf7\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-21T15:03:05.033765Z","caller":"traceutil/trace.go:171","msg":"trace[179973820] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8xhf7; range_end:; response_count:1; response_revision:14178; }","duration":"151.224226ms","start":"2026-05-21T15:03:04.882526Z","end":"2026-05-21T15:03:05.033751Z","steps":["trace[179973820] 'agreement among raft nodes before linearized reading'  (duration: 151.095392ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:04:26.574871Z","caller":"traceutil/trace.go:171","msg":"trace[1589375047] transaction","detail":"{read_only:false; response_revision:14965; number_of_response:1; }","duration":"164.390686ms","start":"2026-05-21T15:04:26.410431Z","end":"2026-05-21T15:04:26.574822Z","steps":["trace[1589375047] 'process raft request'  (duration: 164.14907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:04:26.920478Z","caller":"traceutil/trace.go:171","msg":"trace[348651454] linearizableReadLoop","detail":"{readStateIndex:15473; appliedIndex:15472; }","duration":"269.088962ms","start":"2026-05-21T15:04:26.651336Z","end":"2026-05-21T15:04:26.920425Z","steps":["trace[348651454] 'read index received'  (duration: 215.008847ms)","trace[348651454] 'applied index is now lower than readState.Index'  (duration: 54.078155ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:04:26.920544Z","caller":"traceutil/trace.go:171","msg":"trace[1667941079] transaction","detail":"{read_only:false; response_revision:14966; number_of_response:1; }","duration":"296.554407ms","start":"2026-05-21T15:04:26.623928Z","end":"2026-05-21T15:04:26.920483Z","steps":["trace[1667941079] 'process raft request'  (duration: 242.396329ms)","trace[1667941079] 'compare'  (duration: 53.722106ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:04:26.920808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.449481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-5crkh\" ","response":"range_response_count:1 size:22132"}
{"level":"info","ts":"2026-05-21T15:04:26.920853Z","caller":"traceutil/trace.go:171","msg":"trace[609798634] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-5crkh; range_end:; response_count:1; response_revision:14966; }","duration":"269.569615ms","start":"2026-05-21T15:04:26.651268Z","end":"2026-05-21T15:04:26.920838Z","steps":["trace[609798634] 'agreement among raft nodes before linearized reading'  (duration: 269.332659ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:04:26.955721Z","caller":"traceutil/trace.go:171","msg":"trace[1280448862] transaction","detail":"{read_only:false; response_revision:14967; number_of_response:1; }","duration":"234.876333ms","start":"2026-05-21T15:04:26.720804Z","end":"2026-05-21T15:04:26.95568Z","steps":["trace[1280448862] 'process raft request'  (duration: 234.620336ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:04:26.96728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.279628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-ghscr\" ","response":"range_response_count:1 size:20770"}
{"level":"warn","ts":"2026-05-21T15:04:26.967337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.089947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-5crkh\" ","response":"range_response_count:1 size:22132"}
{"level":"info","ts":"2026-05-21T15:04:26.96741Z","caller":"traceutil/trace.go:171","msg":"trace[1722061784] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-5crkh; range_end:; response_count:1; response_revision:14967; }","duration":"255.270512ms","start":"2026-05-21T15:04:26.71212Z","end":"2026-05-21T15:04:26.96739Z","steps":["trace[1722061784] 'agreement among raft nodes before linearized reading'  (duration: 255.087417ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:04:26.967404Z","caller":"traceutil/trace.go:171","msg":"trace[1352220758] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-ghscr; range_end:; response_count:1; response_revision:14967; }","duration":"150.468954ms","start":"2026-05-21T15:04:26.816908Z","end":"2026-05-21T15:04:26.967377Z","steps":["trace[1352220758] 'agreement among raft nodes before linearized reading'  (duration: 150.186066ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:04:26.967475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.017491ms","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-21T15:04:26.967586Z","caller":"traceutil/trace.go:171","msg":"trace[746184112] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14967; }","duration":"229.185626ms","start":"2026-05-21T15:04:26.738373Z","end":"2026-05-21T15:04:26.967558Z","steps":["trace[746184112] 'agreement among raft nodes before linearized reading'  (duration: 228.849307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:04:27.662976Z","caller":"traceutil/trace.go:171","msg":"trace[100627315] linearizableReadLoop","detail":"{readStateIndex:15478; appliedIndex:15477; }","duration":"158.417782ms","start":"2026-05-21T15:04:27.504537Z","end":"2026-05-21T15:04:27.662955Z","steps":["trace[100627315] 'read index received'  (duration: 158.260727ms)","trace[100627315] 'applied index is now lower than readState.Index'  (duration: 155.965µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:04:27.663096Z","caller":"traceutil/trace.go:171","msg":"trace[569166632] transaction","detail":"{read_only:false; response_revision:14970; number_of_response:1; }","duration":"161.128106ms","start":"2026-05-21T15:04:27.501937Z","end":"2026-05-21T15:04:27.663065Z","steps":["trace[569166632] 'process raft request'  (duration: 160.876559ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:04:27.66321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.645838ms","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-21T15:04:27.663275Z","caller":"traceutil/trace.go:171","msg":"trace[265108988] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14970; }","duration":"158.74346ms","start":"2026-05-21T15:04:27.504514Z","end":"2026-05-21T15:04:27.663258Z","steps":["trace[265108988] 'agreement among raft nodes before linearized reading'  (duration: 158.561885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:04:27.663294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.775778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-05-21T15:04:27.663315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.541196ms","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-21T15:04:27.663338Z","caller":"traceutil/trace.go:171","msg":"trace[215326856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14970; }","duration":"116.830389ms","start":"2026-05-21T15:04:27.546492Z","end":"2026-05-21T15:04:27.663322Z","steps":["trace[215326856] 'agreement among raft nodes before linearized reading'  (duration: 116.749416ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:04:27.663357Z","caller":"traceutil/trace.go:171","msg":"trace[182567208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14970; }","duration":"114.608018ms","start":"2026-05-21T15:04:27.548738Z","end":"2026-05-21T15:04:27.663346Z","steps":["trace[182567208] 'agreement among raft nodes before linearized reading'  (duration: 114.491455ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:04:27.66321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.053597ms","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-21T15:04:27.663439Z","caller":"traceutil/trace.go:171","msg":"trace[881982267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14970; }","duration":"156.319914ms","start":"2026-05-21T15:04:27.507095Z","end":"2026-05-21T15:04:27.663415Z","steps":["trace[881982267] 'agreement among raft nodes before linearized reading'  (duration: 156.012425ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:05:18.333425Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12867}
{"level":"info","ts":"2026-05-21T15:05:18.405826Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12867,"took":"69.953392ms","hash":3858095002,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":30752768,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-21T15:05:18.405944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3858095002,"revision":12867,"compact-revision":10755}
{"level":"info","ts":"2026-05-21T15:10:15.473999Z","caller":"traceutil/trace.go:171","msg":"trace[1726724154] transaction","detail":"{read_only:false; response_revision:17587; number_of_response:1; }","duration":"244.046513ms","start":"2026-05-21T15:10:15.229927Z","end":"2026-05-21T15:10:15.473974Z","steps":["trace[1726724154] 'process raft request'  (duration: 243.892449ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:10:15.485614Z","caller":"traceutil/trace.go:171","msg":"trace[165545065] linearizableReadLoop","detail":"{readStateIndex:18181; appliedIndex:18179; }","duration":"187.309345ms","start":"2026-05-21T15:10:15.298279Z","end":"2026-05-21T15:10:15.485588Z","steps":["trace[165545065] 'read index received'  (duration: 175.530872ms)","trace[165545065] 'applied index is now lower than readState.Index'  (duration: 11.777623ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:10:15.485735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.448469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:10:15.485756Z","caller":"traceutil/trace.go:171","msg":"trace[313827831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17588; }","duration":"187.525632ms","start":"2026-05-21T15:10:15.298224Z","end":"2026-05-21T15:10:15.485749Z","steps":["trace[313827831] 'agreement among raft nodes before linearized reading'  (duration: 187.44682ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:10:15.485879Z","caller":"traceutil/trace.go:171","msg":"trace[155190118] transaction","detail":"{read_only:false; response_revision:17588; number_of_response:1; }","duration":"228.497826ms","start":"2026-05-21T15:10:15.257365Z","end":"2026-05-21T15:10:15.485863Z","steps":["trace[155190118] 'process raft request'  (duration: 228.121246ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:10:18.342788Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15328}
{"level":"info","ts":"2026-05-21T15:10:18.43676Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15328,"took":"90.851686ms","hash":1278042305,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":32022528,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-21T15:10:18.436859Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1278042305,"revision":15328,"compact-revision":12867}
{"level":"info","ts":"2026-05-21T15:13:52.272371Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-21T15:13:52.287338Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-21T15:13:52.287538Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-21T15:15:18.351603Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17666}
{"level":"info","ts":"2026-05-21T15:15:18.450936Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17666,"took":"95.38422ms","hash":799624307,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":33378304,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-21T15:15:18.451049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":799624307,"revision":17666,"compact-revision":15328}
{"level":"info","ts":"2026-05-21T15:15:40.177692Z","caller":"traceutil/trace.go:171","msg":"trace[1586112750] transaction","detail":"{read_only:false; response_revision:20163; number_of_response:1; }","duration":"145.284491ms","start":"2026-05-21T15:15:40.032366Z","end":"2026-05-21T15:15:40.17765Z","steps":["trace[1586112750] 'process raft request'  (duration: 50.416335ms)","trace[1586112750] 'compare'  (duration: 94.589799ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:15:56.193235Z","caller":"traceutil/trace.go:171","msg":"trace[1625547626] transaction","detail":"{read_only:false; response_revision:20245; number_of_response:1; }","duration":"116.282084ms","start":"2026-05-21T15:15:56.076923Z","end":"2026-05-21T15:15:56.193205Z","steps":["trace[1625547626] 'process raft request'  (duration: 116.110239ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:15:56.478483Z","caller":"traceutil/trace.go:171","msg":"trace[1569671977] linearizableReadLoop","detail":"{readStateIndex:20927; appliedIndex:20926; }","duration":"179.542913ms","start":"2026-05-21T15:15:56.298919Z","end":"2026-05-21T15:15:56.478462Z","steps":["trace[1569671977] 'read index received'  (duration: 116.318526ms)","trace[1569671977] 'applied index is now lower than readState.Index'  (duration: 63.223607ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:15:56.478607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.719687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:15:56.478635Z","caller":"traceutil/trace.go:171","msg":"trace[923048487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20246; }","duration":"179.798919ms","start":"2026-05-21T15:15:56.298828Z","end":"2026-05-21T15:15:56.478627Z","steps":["trace[923048487] 'agreement among raft nodes before linearized reading'  (duration: 179.713287ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:15:56.478686Z","caller":"traceutil/trace.go:171","msg":"trace[1201979709] transaction","detail":"{read_only:false; response_revision:20246; number_of_response:1; }","duration":"238.111861ms","start":"2026-05-21T15:15:56.240505Z","end":"2026-05-21T15:15:56.478617Z","steps":["trace[1201979709] 'process raft request'  (duration: 174.792892ms)","trace[1201979709] 'compare'  (duration: 63.079392ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:15:56.748311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.260142ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392871172 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:20237 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:15:56.748482Z","caller":"traceutil/trace.go:171","msg":"trace[782113874] linearizableReadLoop","detail":"{readStateIndex:20928; appliedIndex:20927; }","duration":"159.775789ms","start":"2026-05-21T15:15:56.588683Z","end":"2026-05-21T15:15:56.748458Z","steps":["trace[782113874] 'read index received'  (duration: 15.171616ms)","trace[782113874] 'applied index is now lower than readState.Index'  (duration: 144.602393ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:15:56.74855Z","caller":"traceutil/trace.go:171","msg":"trace[2049902788] transaction","detail":"{read_only:false; response_revision:20247; number_of_response:1; }","duration":"229.35658ms","start":"2026-05-21T15:15:56.519146Z","end":"2026-05-21T15:15:56.748503Z","steps":["trace[2049902788] 'process raft request'  (duration: 84.772428ms)","trace[2049902788] 'compare'  (duration: 144.091218ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:15:56.74862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.893822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:15:56.748725Z","caller":"traceutil/trace.go:171","msg":"trace[1660671621] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:20247; }","duration":"160.066158ms","start":"2026-05-21T15:15:56.588637Z","end":"2026-05-21T15:15:56.748703Z","steps":["trace[1660671621] 'agreement among raft nodes before linearized reading'  (duration: 159.876203ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:15:56.890435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.026282ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392871173 > lease_revoke:<id:47859e4af6540636>","response":"size:29"}
{"level":"info","ts":"2026-05-21T15:15:56.891535Z","caller":"traceutil/trace.go:171","msg":"trace[318644810] transaction","detail":"{read_only:false; response_revision:20248; number_of_response:1; }","duration":"128.692536ms","start":"2026-05-21T15:15:56.762822Z","end":"2026-05-21T15:15:56.891514Z","steps":["trace[318644810] 'process raft request'  (duration: 127.724558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:19:49.956179Z","caller":"traceutil/trace.go:171","msg":"trace[443248354] transaction","detail":"{read_only:false; response_revision:22639; number_of_response:1; }","duration":"269.812768ms","start":"2026-05-21T15:19:49.686321Z","end":"2026-05-21T15:19:49.956134Z","steps":["trace[443248354] 'process raft request'  (duration: 269.688885ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:19:49.956999Z","caller":"traceutil/trace.go:171","msg":"trace[253986347] transaction","detail":"{read_only:false; response_revision:22640; number_of_response:1; }","duration":"193.616645ms","start":"2026-05-21T15:19:49.763358Z","end":"2026-05-21T15:19:49.956974Z","steps":["trace[253986347] 'process raft request'  (duration: 193.401419ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:19:49.957281Z","caller":"traceutil/trace.go:171","msg":"trace[50808599] transaction","detail":"{read_only:false; response_revision:22641; number_of_response:1; }","duration":"175.013264ms","start":"2026-05-21T15:19:49.782183Z","end":"2026-05-21T15:19:49.957196Z","steps":["trace[50808599] 'process raft request'  (duration: 174.760507ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:20:18.357313Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20048}
{"level":"info","ts":"2026-05-21T15:20:18.484825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20048,"took":"124.325964ms","hash":3301738747,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":40968192,"current-db-size-in-use":"41 MB"}
{"level":"info","ts":"2026-05-21T15:20:18.484888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3301738747,"revision":20048,"compact-revision":17666}
{"level":"info","ts":"2026-05-21T15:23:23.010713Z","caller":"traceutil/trace.go:171","msg":"trace[365392382] transaction","detail":"{read_only:false; response_revision:24804; number_of_response:1; }","duration":"113.015222ms","start":"2026-05-21T15:23:22.897655Z","end":"2026-05-21T15:23:23.010671Z","steps":["trace[365392382] 'process raft request'  (duration: 112.693394ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:23.020694Z","caller":"traceutil/trace.go:171","msg":"trace[1754812824] transaction","detail":"{read_only:false; response_revision:24805; number_of_response:1; }","duration":"121.27113ms","start":"2026-05-21T15:23:22.899388Z","end":"2026-05-21T15:23:23.02066Z","steps":["trace[1754812824] 'process raft request'  (duration: 121.017013ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:28.487167Z","caller":"traceutil/trace.go:171","msg":"trace[139012655] linearizableReadLoop","detail":"{readStateIndex:25654; appliedIndex:25653; }","duration":"210.963781ms","start":"2026-05-21T15:23:28.276182Z","end":"2026-05-21T15:23:28.487146Z","steps":["trace[139012655] 'read index received'  (duration: 210.794627ms)","trace[139012655] 'applied index is now lower than readState.Index'  (duration: 168.234µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:28.487268Z","caller":"traceutil/trace.go:171","msg":"trace[682461642] transaction","detail":"{read_only:false; response_revision:24843; number_of_response:1; }","duration":"259.103284ms","start":"2026-05-21T15:23:28.22813Z","end":"2026-05-21T15:23:28.487233Z","steps":["trace[682461642] 'process raft request'  (duration: 258.868427ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:28.487327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.781004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-21T15:23:28.487359Z","caller":"traceutil/trace.go:171","msg":"trace[355297963] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:24843; }","duration":"199.871147ms","start":"2026-05-21T15:23:28.28748Z","end":"2026-05-21T15:23:28.487351Z","steps":["trace[355297963] 'agreement among raft nodes before linearized reading'  (duration: 199.782174ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:28.48736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.192938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:28.487432Z","caller":"traceutil/trace.go:171","msg":"trace[1287073514] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24843; }","duration":"211.317662ms","start":"2026-05-21T15:23:28.276096Z","end":"2026-05-21T15:23:28.487413Z","steps":["trace[1287073514] 'agreement among raft nodes before linearized reading'  (duration: 211.158317ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:28.888372Z","caller":"traceutil/trace.go:171","msg":"trace[1247281699] transaction","detail":"{read_only:false; response_revision:24844; number_of_response:1; }","duration":"242.537878ms","start":"2026-05-21T15:23:28.645811Z","end":"2026-05-21T15:23:28.888348Z","steps":["trace[1247281699] 'process raft request'  (duration: 242.396414ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:28.889232Z","caller":"traceutil/trace.go:171","msg":"trace[816515780] transaction","detail":"{read_only:false; response_revision:24846; number_of_response:1; }","duration":"136.288711ms","start":"2026-05-21T15:23:28.752926Z","end":"2026-05-21T15:23:28.889215Z","steps":["trace[816515780] 'process raft request'  (duration: 136.25388ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:28.889449Z","caller":"traceutil/trace.go:171","msg":"trace[2126453295] transaction","detail":"{read_only:false; response_revision:24845; number_of_response:1; }","duration":"138.657217ms","start":"2026-05-21T15:23:28.750783Z","end":"2026-05-21T15:23:28.88944Z","steps":["trace[2126453295] 'process raft request'  (duration: 138.293277ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:33.013471Z","caller":"traceutil/trace.go:171","msg":"trace[1993633861] transaction","detail":"{read_only:false; response_revision:24881; number_of_response:1; }","duration":"111.47933ms","start":"2026-05-21T15:23:32.901971Z","end":"2026-05-21T15:23:33.01345Z","steps":["trace[1993633861] 'process raft request'  (duration: 111.340307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:33.173876Z","caller":"traceutil/trace.go:171","msg":"trace[1152626651] linearizableReadLoop","detail":"{readStateIndex:25695; appliedIndex:25692; }","duration":"255.605867ms","start":"2026-05-21T15:23:32.918243Z","end":"2026-05-21T15:23:33.173849Z","steps":["trace[1152626651] 'read index received'  (duration: 95.131431ms)","trace[1152626651] 'applied index is now lower than readState.Index'  (duration: 160.472726ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:33.174015Z","caller":"traceutil/trace.go:171","msg":"trace[46304712] transaction","detail":"{read_only:false; response_revision:24882; number_of_response:1; }","duration":"270.036813ms","start":"2026-05-21T15:23:32.90396Z","end":"2026-05-21T15:23:33.173996Z","steps":["trace[46304712] 'process raft request'  (duration: 247.360091ms)","trace[46304712] 'compare'  (duration: 22.003824ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:33.174089Z","caller":"traceutil/trace.go:171","msg":"trace[1630631924] transaction","detail":"{read_only:false; response_revision:24883; number_of_response:1; }","duration":"266.554228ms","start":"2026-05-21T15:23:32.907511Z","end":"2026-05-21T15:23:33.174065Z","steps":["trace[1630631924] 'process raft request'  (duration: 266.26958ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:33.174266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.015218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:33.174298Z","caller":"traceutil/trace.go:171","msg":"trace[453513785] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:24883; }","duration":"256.088851ms","start":"2026-05-21T15:23:32.9182Z","end":"2026-05-21T15:23:33.174289Z","steps":["trace[453513785] 'agreement among raft nodes before linearized reading'  (duration: 256.015679ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:33.180235Z","caller":"traceutil/trace.go:171","msg":"trace[861705082] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"130.522103ms","start":"2026-05-21T15:23:33.049699Z","end":"2026-05-21T15:23:33.180221Z","steps":["trace[861705082] 'process raft request'  (duration: 130.388899ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:33.18045Z","caller":"traceutil/trace.go:171","msg":"trace[1718515074] transaction","detail":"{read_only:false; response_revision:24885; number_of_response:1; }","duration":"127.937982ms","start":"2026-05-21T15:23:33.052482Z","end":"2026-05-21T15:23:33.18042Z","steps":["trace[1718515074] 'process raft request'  (duration: 127.700176ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:33.180476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.37864ms","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-21T15:23:33.180587Z","caller":"traceutil/trace.go:171","msg":"trace[968210612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24885; }","duration":"110.536864ms","start":"2026-05-21T15:23:33.070039Z","end":"2026-05-21T15:23:33.180576Z","steps":["trace[968210612] 'agreement among raft nodes before linearized reading'  (duration: 110.333409ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:33.318982Z","caller":"traceutil/trace.go:171","msg":"trace[44801766] transaction","detail":"{read_only:false; response_revision:24886; number_of_response:1; }","duration":"134.418871ms","start":"2026-05-21T15:23:33.184521Z","end":"2026-05-21T15:23:33.318939Z","steps":["trace[44801766] 'process raft request'  (duration: 89.445376ms)","trace[44801766] 'compare'  (duration: 44.775349ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:34.248115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.471959ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883452 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24876 > 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:18"}
{"level":"info","ts":"2026-05-21T15:23:34.248255Z","caller":"traceutil/trace.go:171","msg":"trace[1197810285] linearizableReadLoop","detail":"{readStateIndex:25701; appliedIndex:25699; }","duration":"337.073584ms","start":"2026-05-21T15:23:33.91114Z","end":"2026-05-21T15:23:34.248214Z","steps":["trace[1197810285] 'read index received'  (duration: 63.097033ms)","trace[1197810285] 'applied index is now lower than readState.Index'  (duration: 273.974871ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:34.248277Z","caller":"traceutil/trace.go:171","msg":"trace[1264003861] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"346.935614ms","start":"2026-05-21T15:23:33.901314Z","end":"2026-05-21T15:23:34.24825Z","steps":["trace[1264003861] 'process raft request'  (duration: 148.228879ms)","trace[1264003861] 'compare'  (duration: 197.856632ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:34.248411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:33.901289Z","time spent":"347.044839ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24876 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:34.24848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.335982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-21T15:23:34.24852Z","caller":"traceutil/trace.go:171","msg":"trace[247670772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24889; }","duration":"337.375573ms","start":"2026-05-21T15:23:33.911133Z","end":"2026-05-21T15:23:34.248509Z","steps":["trace[247670772] 'agreement among raft nodes before linearized reading'  (duration: 337.196468ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:34.248562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:33.911115Z","time spent":"337.439195ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-21T15:23:34.248729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.289033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-21T15:23:34.248764Z","caller":"traceutil/trace.go:171","msg":"trace[710714336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24889; }","duration":"336.361865ms","start":"2026-05-21T15:23:33.912392Z","end":"2026-05-21T15:23:34.248753Z","steps":["trace[710714336] 'agreement among raft nodes before linearized reading'  (duration: 336.257552ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:34.248788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:33.912373Z","time spent":"336.410656ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-21T15:23:34.248911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.98802ms","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-21T15:23:34.248956Z","caller":"traceutil/trace.go:171","msg":"trace[1704406119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24889; }","duration":"287.062652ms","start":"2026-05-21T15:23:33.961881Z","end":"2026-05-21T15:23:34.248944Z","steps":["trace[1704406119] 'agreement among raft nodes before linearized reading'  (duration: 286.960359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:34.818213Z","caller":"traceutil/trace.go:171","msg":"trace[1994967726] linearizableReadLoop","detail":"{readStateIndex:25706; appliedIndex:25705; }","duration":"176.836805ms","start":"2026-05-21T15:23:34.641345Z","end":"2026-05-21T15:23:34.818182Z","steps":["trace[1994967726] 'read index received'  (duration: 142.337928ms)","trace[1994967726] 'applied index is now lower than readState.Index'  (duration: 34.497587ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:34.818384Z","caller":"traceutil/trace.go:171","msg":"trace[1766797097] transaction","detail":"{read_only:false; response_revision:24894; number_of_response:1; }","duration":"203.507417ms","start":"2026-05-21T15:23:34.61484Z","end":"2026-05-21T15:23:34.818348Z","steps":["trace[1766797097] 'process raft request'  (duration: 168.833446ms)","trace[1766797097] 'compare'  (duration: 34.063775ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:34.818485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.120132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-l3-agent-default-9gf6s.18b19d4f0da134ed\" ","response":"range_response_count:1 size:949"}
{"level":"info","ts":"2026-05-21T15:23:34.81854Z","caller":"traceutil/trace.go:171","msg":"trace[410771478] range","detail":"{range_begin:/registry/events/openstack/neutron-l3-agent-default-9gf6s.18b19d4f0da134ed; range_end:; response_count:1; response_revision:24894; }","duration":"177.233005ms","start":"2026-05-21T15:23:34.641292Z","end":"2026-05-21T15:23:34.818525Z","steps":["trace[410771478] 'agreement among raft nodes before linearized reading'  (duration: 177.005689ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:35.071626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.225289ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883463 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/neutron-l3-agent-default-9gf6s.18b19d4f0da134ed\" mod_revision:24615 > success:<request_put:<key:\"/registry/events/openstack/neutron-l3-agent-default-9gf6s.18b19d4f0da134ed\" value_size:839 lease:5153699393392882130 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-l3-agent-default-9gf6s.18b19d4f0da134ed\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:35.071741Z","caller":"traceutil/trace.go:171","msg":"trace[229176990] transaction","detail":"{read_only:false; response_revision:24895; number_of_response:1; }","duration":"250.530399ms","start":"2026-05-21T15:23:34.82119Z","end":"2026-05-21T15:23:35.071721Z","steps":["trace[229176990] 'process raft request'  (duration: 114.121304ms)","trace[229176990] 'compare'  (duration: 136.109146ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:35.330115Z","caller":"traceutil/trace.go:171","msg":"trace[1993323530] transaction","detail":"{read_only:false; response_revision:24897; number_of_response:1; }","duration":"151.577952ms","start":"2026-05-21T15:23:35.178502Z","end":"2026-05-21T15:23:35.33008Z","steps":["trace[1993323530] 'process raft request'  (duration: 53.099658ms)","trace[1993323530] 'compare'  (duration: 98.321149ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:35.668599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.334236ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883467 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24882 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:35.669029Z","caller":"traceutil/trace.go:171","msg":"trace[1502706023] linearizableReadLoop","detail":"{readStateIndex:25712; appliedIndex:25709; }","duration":"410.260935ms","start":"2026-05-21T15:23:35.258746Z","end":"2026-05-21T15:23:35.669007Z","steps":["trace[1502706023] 'read index received'  (duration: 231.484976ms)","trace[1502706023] 'applied index is now lower than readState.Index'  (duration: 178.774339ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:35.669125Z","caller":"traceutil/trace.go:171","msg":"trace[1749477185] transaction","detail":"{read_only:false; response_revision:24898; number_of_response:1; }","duration":"488.028ms","start":"2026-05-21T15:23:35.181063Z","end":"2026-05-21T15:23:35.669091Z","steps":["trace[1749477185] 'process raft request'  (duration: 309.089067ms)","trace[1749477185] 'compare'  (duration: 178.065859ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:35.66915Z","caller":"traceutil/trace.go:171","msg":"trace[1414298399] transaction","detail":"{read_only:false; response_revision:24899; number_of_response:1; }","duration":"484.846712ms","start":"2026-05-21T15:23:35.184262Z","end":"2026-05-21T15:23:35.669109Z","steps":["trace[1414298399] 'process raft request'  (duration: 484.520633ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:35.669162Z","caller":"traceutil/trace.go:171","msg":"trace[160482358] transaction","detail":"{read_only:false; response_revision:24900; number_of_response:1; }","duration":"484.80009ms","start":"2026-05-21T15:23:35.184314Z","end":"2026-05-21T15:23:35.669114Z","steps":["trace[160482358] 'process raft request'  (duration: 484.559313ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:35.669244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.485551ms","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-21T15:23:35.669226Z","caller":"traceutil/trace.go:171","msg":"trace[152328143] transaction","detail":"{read_only:false; response_revision:24901; number_of_response:1; }","duration":"259.471195ms","start":"2026-05-21T15:23:35.409712Z","end":"2026-05-21T15:23:35.669183Z","steps":["trace[152328143] 'process raft request'  (duration: 259.256519ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:35.669278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:35.18103Z","time spent":"488.167604ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24882 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:35.669284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:35.184253Z","time spent":"484.948874ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24885 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-21T15:23:35.669302Z","caller":"traceutil/trace.go:171","msg":"trace[946236928] 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:24901; }","duration":"410.587574ms","start":"2026-05-21T15:23:35.2587Z","end":"2026-05-21T15:23:35.669288Z","steps":["trace[946236928] 'agreement among raft nodes before linearized reading'  (duration: 410.4415ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:35.669304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.667569ms","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-21T15:23:35.669243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.870629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-21T15:23:35.669345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:35.258682Z","time spent":"410.652365ms","remote":"127.0.0.1:49450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-05-21T15:23:35.669319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.21698ms","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":"info","ts":"2026-05-21T15:23:35.669353Z","caller":"traceutil/trace.go:171","msg":"trace[570419871] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24901; }","duration":"346.74588ms","start":"2026-05-21T15:23:35.322595Z","end":"2026-05-21T15:23:35.669341Z","steps":["trace[570419871] 'agreement among raft nodes before linearized reading'  (duration: 346.584786ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:35.6694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:35.322522Z","time spent":"346.869843ms","remote":"127.0.0.1:38768","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":"info","ts":"2026-05-21T15:23:35.669404Z","caller":"traceutil/trace.go:171","msg":"trace[1901255394] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24901; }","duration":"297.380794ms","start":"2026-05-21T15:23:35.372003Z","end":"2026-05-21T15:23:35.669384Z","steps":["trace[1901255394] 'agreement among raft nodes before linearized reading'  (duration: 297.21032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:35.669405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:35.184309Z","time spent":"484.964774ms","remote":"127.0.0.1:38768","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/capo-system/controller-leader-election-capo\" mod_revision:24884 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-05-21T15:23:35.669406Z","caller":"traceutil/trace.go:171","msg":"trace[1792937340] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:24901; }","duration":"176.064044ms","start":"2026-05-21T15:23:35.493309Z","end":"2026-05-21T15:23:35.669373Z","steps":["trace[1792937340] 'agreement among raft nodes before linearized reading'  (duration: 175.874469ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:36.11523Z","caller":"traceutil/trace.go:171","msg":"trace[626491446] transaction","detail":"{read_only:false; response_revision:24903; number_of_response:1; }","duration":"348.798677ms","start":"2026-05-21T15:23:35.766398Z","end":"2026-05-21T15:23:36.115197Z","steps":["trace[626491446] 'process raft request'  (duration: 348.605022ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:36.115405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:35.766371Z","time spent":"348.943221ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24887 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-21T15:23:36.119139Z","caller":"traceutil/trace.go:171","msg":"trace[228398767] transaction","detail":"{read_only:false; response_revision:24904; number_of_response:1; }","duration":"138.000139ms","start":"2026-05-21T15:23:35.981102Z","end":"2026-05-21T15:23:36.119102Z","steps":["trace[228398767] 'process raft request'  (duration: 137.758882ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:36.442532Z","caller":"traceutil/trace.go:171","msg":"trace[1852069883] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"134.248956ms","start":"2026-05-21T15:23:36.308235Z","end":"2026-05-21T15:23:36.442484Z","steps":["trace[1852069883] 'process raft request'  (duration: 130.231445ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:49.880834Z","caller":"traceutil/trace.go:171","msg":"trace[1195662726] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"160.355032ms","start":"2026-05-21T15:23:49.720433Z","end":"2026-05-21T15:23:49.880788Z","steps":["trace[1195662726] 'process raft request'  (duration: 160.097225ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.09917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.419534ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883883 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24989 > 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:18"}
{"level":"info","ts":"2026-05-21T15:23:50.099381Z","caller":"traceutil/trace.go:171","msg":"trace[2013194409] linearizableReadLoop","detail":"{readStateIndex:25877; appliedIndex:25874; }","duration":"347.271945ms","start":"2026-05-21T15:23:49.752094Z","end":"2026-05-21T15:23:50.099366Z","steps":["trace[2013194409] 'read index received'  (duration: 128.393576ms)","trace[2013194409] 'applied index is now lower than readState.Index'  (duration: 218.877429ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:50.099652Z","caller":"traceutil/trace.go:171","msg":"trace[317768284] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"368.937639ms","start":"2026-05-21T15:23:49.73067Z","end":"2026-05-21T15:23:50.099607Z","steps":["trace[317768284] 'process raft request'  (duration: 258.971221ms)","trace[317768284] 'compare'  (duration: 109.007092ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:50.09972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.607294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-21T15:23:50.099762Z","caller":"traceutil/trace.go:171","msg":"trace[1100981374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25061; }","duration":"347.686595ms","start":"2026-05-21T15:23:49.752063Z","end":"2026-05-21T15:23:50.09975Z","steps":["trace[1100981374] 'agreement among raft nodes before linearized reading'  (duration: 347.49701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.099794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:49.752053Z","time spent":"347.735447ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-21T15:23:50.099809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:49.73065Z","time spent":"369.083203ms","remote":"127.0.0.1:38768","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:24989 > 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-21T15:23:50.099884Z","caller":"traceutil/trace.go:171","msg":"trace[1287045638] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"358.528244ms","start":"2026-05-21T15:23:49.741342Z","end":"2026-05-21T15:23:50.099871Z","steps":["trace[1287045638] 'process raft request'  (duration: 357.938798ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.099987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:49.741327Z","time spent":"358.598745ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24990 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:50.100059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.362037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-05-21T15:23:50.100197Z","caller":"traceutil/trace.go:171","msg":"trace[320072353] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3; range_end:; response_count:1; response_revision:25061; }","duration":"229.583563ms","start":"2026-05-21T15:23:49.870576Z","end":"2026-05-21T15:23:50.10016Z","steps":["trace[320072353] 'agreement among raft nodes before linearized reading'  (duration: 229.208503ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.489581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.128738ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883887 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" mod_revision:25042 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" value_size:3643 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:50.489794Z","caller":"traceutil/trace.go:171","msg":"trace[1116267586] linearizableReadLoop","detail":"{readStateIndex:25879; appliedIndex:25877; }","duration":"345.074003ms","start":"2026-05-21T15:23:50.144706Z","end":"2026-05-21T15:23:50.48978Z","steps":["trace[1116267586] 'read index received'  (duration: 161.643128ms)","trace[1116267586] 'applied index is now lower than readState.Index'  (duration: 183.429815ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:50.490021Z","caller":"traceutil/trace.go:171","msg":"trace[1925484160] transaction","detail":"{read_only:false; response_revision:25064; number_of_response:1; }","duration":"309.098395ms","start":"2026-05-21T15:23:50.180901Z","end":"2026-05-21T15:23:50.49Z","steps":["trace[1925484160] 'process raft request'  (duration: 308.842598ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:50.490053Z","caller":"traceutil/trace.go:171","msg":"trace[1876555888] transaction","detail":"{read_only:false; response_revision:25063; number_of_response:1; }","duration":"381.697849ms","start":"2026-05-21T15:23:50.108326Z","end":"2026-05-21T15:23:50.490024Z","steps":["trace[1876555888] 'process raft request'  (duration: 381.36169ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.490248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:50.108301Z","time spent":"381.849823ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24991 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:50.490055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.32557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-21T15:23:50.4901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:50.180868Z","time spent":"309.197158ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24998 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-21T15:23:50.490346Z","caller":"traceutil/trace.go:171","msg":"trace[952536825] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25064; }","duration":"345.653079ms","start":"2026-05-21T15:23:50.144663Z","end":"2026-05-21T15:23:50.490316Z","steps":["trace[952536825] 'agreement among raft nodes before linearized reading'  (duration: 345.33238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:50.489815Z","caller":"traceutil/trace.go:171","msg":"trace[573083773] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"381.461543ms","start":"2026-05-21T15:23:50.108297Z","end":"2026-05-21T15:23:50.489759Z","steps":["trace[573083773] 'process raft request'  (duration: 198.081149ms)","trace[573083773] 'compare'  (duration: 182.690835ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:50.490449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:50.144647Z","time spent":"345.762892ms","remote":"127.0.0.1:49462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T15:23:50.490563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:50.108267Z","time spent":"382.198383ms","remote":"127.0.0.1:38692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3743,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" mod_revision:25042 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" value_size:3643 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" > >"}
{"level":"info","ts":"2026-05-21T15:23:50.502821Z","caller":"traceutil/trace.go:171","msg":"trace[2055156150] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"150.103282ms","start":"2026-05-21T15:23:50.352685Z","end":"2026-05-21T15:23:50.502788Z","steps":["trace[2055156150] 'process raft request'  (duration: 149.936637ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.502885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.526072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" ","response":"range_response_count:1 size:3761"}
{"level":"info","ts":"2026-05-21T15:23:50.502939Z","caller":"traceutil/trace.go:171","msg":"trace[1722384236] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3; range_end:; response_count:1; response_revision:25065; }","duration":"170.646385ms","start":"2026-05-21T15:23:50.332278Z","end":"2026-05-21T15:23:50.502925Z","steps":["trace[1722384236] 'agreement among raft nodes before linearized reading'  (duration: 170.529481ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.503153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.659659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:50.503177Z","caller":"traceutil/trace.go:171","msg":"trace[1891870453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25065; }","duration":"204.734231ms","start":"2026-05-21T15:23:50.298435Z","end":"2026-05-21T15:23:50.50317Z","steps":["trace[1891870453] 'agreement among raft nodes before linearized reading'  (duration: 204.69273ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.503352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.612148ms","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-21T15:23:50.503387Z","caller":"traceutil/trace.go:171","msg":"trace[407104485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25065; }","duration":"318.68328ms","start":"2026-05-21T15:23:50.184697Z","end":"2026-05-21T15:23:50.50338Z","steps":["trace[407104485] 'agreement among raft nodes before linearized reading'  (duration: 318.564527ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.503404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:50.184683Z","time spent":"318.716871ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-21T15:23:50.859142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.174529ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883898 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25048 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:50.859256Z","caller":"traceutil/trace.go:171","msg":"trace[1764651986] transaction","detail":"{read_only:false; response_revision:25067; number_of_response:1; }","duration":"294.408553ms","start":"2026-05-21T15:23:50.564836Z","end":"2026-05-21T15:23:50.859244Z","steps":["trace[1764651986] 'process raft request'  (duration: 127.071179ms)","trace[1764651986] 'compare'  (duration: 166.837421ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:50.859561Z","caller":"traceutil/trace.go:171","msg":"trace[1211055371] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"294.702071ms","start":"2026-05-21T15:23:50.564853Z","end":"2026-05-21T15:23:50.859555Z","steps":["trace[1211055371] 'process raft request'  (duration: 294.357981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:50.859673Z","caller":"traceutil/trace.go:171","msg":"trace[1791952931] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"212.391492ms","start":"2026-05-21T15:23:50.647276Z","end":"2026-05-21T15:23:50.859667Z","steps":["trace[1791952931] 'process raft request'  (duration: 212.142765ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:50.859608Z","caller":"traceutil/trace.go:171","msg":"trace[955272269] linearizableReadLoop","detail":"{readStateIndex:25884; appliedIndex:25882; }","duration":"290.624979ms","start":"2026-05-21T15:23:50.568956Z","end":"2026-05-21T15:23:50.859581Z","steps":["trace[955272269] 'read index received'  (duration: 122.980427ms)","trace[955272269] 'applied index is now lower than readState.Index'  (duration: 167.643282ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:50.859887Z","caller":"traceutil/trace.go:171","msg":"trace[694297165] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"171.320883ms","start":"2026-05-21T15:23:50.688561Z","end":"2026-05-21T15:23:50.859881Z","steps":["trace[694297165] 'process raft request'  (duration: 170.958584ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:50.860281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.308637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-21T15:23:50.860345Z","caller":"traceutil/trace.go:171","msg":"trace[971039236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25070; }","duration":"291.41173ms","start":"2026-05-21T15:23:50.568917Z","end":"2026-05-21T15:23:50.860329Z","steps":["trace[971039236] 'agreement among raft nodes before linearized reading'  (duration: 290.985109ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:51.206508Z","caller":"traceutil/trace.go:171","msg":"trace[1154687952] linearizableReadLoop","detail":"{readStateIndex:25887; appliedIndex:25886; }","duration":"180.463835ms","start":"2026-05-21T15:23:51.026019Z","end":"2026-05-21T15:23:51.206482Z","steps":["trace[1154687952] 'read index received'  (duration: 142.457641ms)","trace[1154687952] 'applied index is now lower than readState.Index'  (duration: 38.004974ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:51.20663Z","caller":"traceutil/trace.go:171","msg":"trace[1001822142] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"341.198797ms","start":"2026-05-21T15:23:50.865421Z","end":"2026-05-21T15:23:51.206619Z","steps":["trace[1001822142] 'process raft request'  (duration: 302.961487ms)","trace[1001822142] 'compare'  (duration: 37.950253ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:51.206731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:50.865395Z","time spent":"341.257789ms","remote":"127.0.0.1:38768","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:25050 > 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-21T15:23:51.206901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.829464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:51.207008Z","caller":"traceutil/trace.go:171","msg":"trace[1289402547] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:25071; }","duration":"181.03978ms","start":"2026-05-21T15:23:51.025942Z","end":"2026-05-21T15:23:51.206982Z","steps":["trace[1289402547] 'agreement among raft nodes before linearized reading'  (duration: 180.781253ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:51.301642Z","caller":"traceutil/trace.go:171","msg":"trace[848677924] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"151.852999ms","start":"2026-05-21T15:23:51.149762Z","end":"2026-05-21T15:23:51.301615Z","steps":["trace[848677924] 'process raft request'  (duration: 151.668404ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:51.301803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.105879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-05-21T15:23:51.301884Z","caller":"traceutil/trace.go:171","msg":"trace[314281258] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:25072; }","duration":"100.259833ms","start":"2026-05-21T15:23:51.201608Z","end":"2026-05-21T15:23:51.301868Z","steps":["trace[314281258] 'agreement among raft nodes before linearized reading'  (duration: 99.967555ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:51.720798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.377874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-21T15:23:51.720934Z","caller":"traceutil/trace.go:171","msg":"trace[929490963] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:25073; }","duration":"168.589799ms","start":"2026-05-21T15:23:51.552317Z","end":"2026-05-21T15:23:51.720907Z","steps":["trace[929490963] 'range keys from in-memory index tree'  (duration: 168.093476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:52.028523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.805503ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883917 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24910 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:52.028786Z","caller":"traceutil/trace.go:171","msg":"trace[1522814733] linearizableReadLoop","detail":"{readStateIndex:25892; appliedIndex:25890; }","duration":"241.720927ms","start":"2026-05-21T15:23:51.787048Z","end":"2026-05-21T15:23:52.028769Z","steps":["trace[1522814733] 'read index received'  (duration: 87.589595ms)","trace[1522814733] 'applied index is now lower than readState.Index'  (duration: 154.127272ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:52.028861Z","caller":"traceutil/trace.go:171","msg":"trace[1419729523] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"280.073539ms","start":"2026-05-21T15:23:51.748778Z","end":"2026-05-21T15:23:52.028852Z","steps":["trace[1419729523] 'process raft request'  (duration: 279.852032ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:52.028887Z","caller":"traceutil/trace.go:171","msg":"trace[1278874055] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"303.079072ms","start":"2026-05-21T15:23:51.725769Z","end":"2026-05-21T15:23:52.028848Z","steps":["trace[1278874055] 'process raft request'  (duration: 148.852168ms)","trace[1278874055] 'compare'  (duration: 153.586656ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:52.028984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:51.725738Z","time spent":"303.199225ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24910 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:52.029319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.060127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:52.029411Z","caller":"traceutil/trace.go:171","msg":"trace[1672906354] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:25075; }","duration":"242.401266ms","start":"2026-05-21T15:23:51.786984Z","end":"2026-05-21T15:23:52.029386Z","steps":["trace[1672906354] 'agreement among raft nodes before linearized reading'  (duration: 241.872351ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:52.088492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.56944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:52.088501Z","caller":"traceutil/trace.go:171","msg":"trace[1355786576] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"202.608343ms","start":"2026-05-21T15:23:51.885851Z","end":"2026-05-21T15:23:52.088459Z","steps":["trace[1355786576] 'process raft request'  (duration: 202.338935ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:52.088584Z","caller":"traceutil/trace.go:171","msg":"trace[225133353] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:25077; }","duration":"250.730204ms","start":"2026-05-21T15:23:51.837836Z","end":"2026-05-21T15:23:52.088567Z","steps":["trace[225133353] 'agreement among raft nodes before linearized reading'  (duration: 250.55712ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:52.08883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.086785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-21T15:23:52.089007Z","caller":"traceutil/trace.go:171","msg":"trace[1993971285] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25077; }","duration":"266.320792ms","start":"2026-05-21T15:23:51.82266Z","end":"2026-05-21T15:23:52.088981Z","steps":["trace[1993971285] 'agreement among raft nodes before linearized reading'  (duration: 266.029414ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:52.298297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.088984ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883926 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25060 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:52.298411Z","caller":"traceutil/trace.go:171","msg":"trace[658922576] linearizableReadLoop","detail":"{readStateIndex:25896; appliedIndex:25894; }","duration":"135.724837ms","start":"2026-05-21T15:23:52.162674Z","end":"2026-05-21T15:23:52.298399Z","steps":["trace[658922576] 'read index received'  (duration: 6.488138ms)","trace[658922576] 'applied index is now lower than readState.Index'  (duration: 129.236089ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:52.298477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.81305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-21T15:23:52.298489Z","caller":"traceutil/trace.go:171","msg":"trace[1691947950] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:25079; }","duration":"135.879371ms","start":"2026-05-21T15:23:52.162605Z","end":"2026-05-21T15:23:52.298484Z","steps":["trace[1691947950] 'agreement among raft nodes before linearized reading'  (duration: 135.821909ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:52.298695Z","caller":"traceutil/trace.go:171","msg":"trace[270618963] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"193.349868ms","start":"2026-05-21T15:23:52.105295Z","end":"2026-05-21T15:23:52.298645Z","steps":["trace[270618963] 'process raft request'  (duration: 193.072701ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:52.298732Z","caller":"traceutil/trace.go:171","msg":"trace[1360329934] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"194.086828ms","start":"2026-05-21T15:23:52.104637Z","end":"2026-05-21T15:23:52.298724Z","steps":["trace[1360329934] 'process raft request'  (duration: 64.515971ms)","trace[1360329934] 'compare'  (duration: 128.742125ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:52.894761Z","caller":"traceutil/trace.go:171","msg":"trace[1966471980] linearizableReadLoop","detail":"{readStateIndex:25899; appliedIndex:25898; }","duration":"292.940793ms","start":"2026-05-21T15:23:52.601792Z","end":"2026-05-21T15:23:52.894733Z","steps":["trace[1966471980] 'read index received'  (duration: 202.082188ms)","trace[1966471980] 'applied index is now lower than readState.Index'  (duration: 90.857465ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:52.894811Z","caller":"traceutil/trace.go:171","msg":"trace[142927104] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"303.77276ms","start":"2026-05-21T15:23:52.59101Z","end":"2026-05-21T15:23:52.894783Z","steps":["trace[142927104] 'process raft request'  (duration: 212.877034ms)","trace[142927104] 'compare'  (duration: 90.716431ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:52.89495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:52.590983Z","time spent":"303.887064ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25063 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:52.895111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.072532ms","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-21T15:23:52.895163Z","caller":"traceutil/trace.go:171","msg":"trace[1432501504] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25082; }","duration":"330.270408ms","start":"2026-05-21T15:23:52.564876Z","end":"2026-05-21T15:23:52.895146Z","steps":["trace[1432501504] 'agreement among raft nodes before linearized reading'  (duration: 329.987051ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:52.895207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:52.56484Z","time spent":"330.356131ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-21T15:23:52.895192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.028413ms","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-21T15:23:52.895285Z","caller":"traceutil/trace.go:171","msg":"trace[1823103166] 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:25082; }","duration":"345.205257ms","start":"2026-05-21T15:23:52.550054Z","end":"2026-05-21T15:23:52.89526Z","steps":["trace[1823103166] 'agreement among raft nodes before linearized reading'  (duration: 345.012842ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:52.895338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:52.55003Z","time spent":"345.29236ms","remote":"127.0.0.1:49310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T15:23:53.171757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.827436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883938 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25066 > 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-21T15:23:53.17205Z","caller":"traceutil/trace.go:171","msg":"trace[2017642844] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"272.730258ms","start":"2026-05-21T15:23:52.89926Z","end":"2026-05-21T15:23:53.17199Z","steps":["trace[2017642844] 'process raft request'  (duration: 147.575302ms)","trace[2017642844] 'compare'  (duration: 124.544989ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:53.172173Z","caller":"traceutil/trace.go:171","msg":"trace[1186406843] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"214.972462ms","start":"2026-05-21T15:23:52.957137Z","end":"2026-05-21T15:23:53.172109Z","steps":["trace[1186406843] 'process raft request'  (duration: 214.742486ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:53.172422Z","caller":"traceutil/trace.go:171","msg":"trace[1833889945] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"207.21277ms","start":"2026-05-21T15:23:52.965197Z","end":"2026-05-21T15:23:53.17241Z","steps":["trace[1833889945] 'process raft request'  (duration: 206.803058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:53.780712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.720193ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392883947 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25071 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-21T15:23:53.780849Z","caller":"traceutil/trace.go:171","msg":"trace[2096160005] linearizableReadLoop","detail":"{readStateIndex:25904; appliedIndex:25903; }","duration":"535.258795ms","start":"2026-05-21T15:23:53.245566Z","end":"2026-05-21T15:23:53.780825Z","steps":["trace[2096160005] 'read index received'  (duration: 48.340237ms)","trace[2096160005] 'applied index is now lower than readState.Index'  (duration: 486.916638ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:23:53.781252Z","caller":"traceutil/trace.go:171","msg":"trace[519386615] transaction","detail":"{read_only:false; response_revision:25087; number_of_response:1; }","duration":"563.509201ms","start":"2026-05-21T15:23:53.217696Z","end":"2026-05-21T15:23:53.781205Z","steps":["trace[519386615] 'process raft request'  (duration: 76.170021ms)","trace[519386615] 'compare'  (duration: 486.185648ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:23:53.781292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.717057ms","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-21T15:23:53.781349Z","caller":"traceutil/trace.go:171","msg":"trace[496099594] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25087; }","duration":"535.785479ms","start":"2026-05-21T15:23:53.24555Z","end":"2026-05-21T15:23:53.781335Z","steps":["trace[496099594] 'agreement among raft nodes before linearized reading'  (duration: 535.678836ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:53.781344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:53.217669Z","time spent":"563.629654ms","remote":"127.0.0.1:38768","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:25071 > 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":"warn","ts":"2026-05-21T15:23:53.781385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:53.245495Z","time spent":"535.883542ms","remote":"127.0.0.1:38924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-05-21T15:23:53.81354Z","caller":"traceutil/trace.go:171","msg":"trace[922823229] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"506.26952ms","start":"2026-05-21T15:23:53.307244Z","end":"2026-05-21T15:23:53.813514Z","steps":["trace[922823229] 'process raft request'  (duration: 506.085475ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:53.813698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:53.307212Z","time spent":"506.401414ms","remote":"127.0.0.1:38768","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:25072 > 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":"warn","ts":"2026-05-21T15:23:53.838294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.411892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3\" ","response":"range_response_count:1 size:3761"}
{"level":"info","ts":"2026-05-21T15:23:53.838476Z","caller":"traceutil/trace.go:171","msg":"trace[1982629993] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f1591c7-14b6-4681-918a-c136a053def3; range_end:; response_count:1; response_revision:25090; }","duration":"231.626329ms","start":"2026-05-21T15:23:53.606833Z","end":"2026-05-21T15:23:53.838459Z","steps":["trace[1982629993] 'agreement among raft nodes before linearized reading'  (duration: 231.366731ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:53.838477Z","caller":"traceutil/trace.go:171","msg":"trace[921348292] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"358.618696ms","start":"2026-05-21T15:23:53.479834Z","end":"2026-05-21T15:23:53.838452Z","steps":["trace[921348292] 'process raft request'  (duration: 358.224444ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:53.838293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.483635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-21T15:23:53.838756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.580557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-21T15:23:53.838843Z","caller":"traceutil/trace.go:171","msg":"trace[1032808356] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:25090; }","duration":"432.711801ms","start":"2026-05-21T15:23:53.406109Z","end":"2026-05-21T15:23:53.838821Z","steps":["trace[1032808356] 'agreement among raft nodes before linearized reading'  (duration: 432.588148ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:53.838897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:53.406087Z","time spent":"432.791703ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "}
{"level":"info","ts":"2026-05-21T15:23:53.838768Z","caller":"traceutil/trace.go:171","msg":"trace[1702121447] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25090; }","duration":"227.99131ms","start":"2026-05-21T15:23:53.610764Z","end":"2026-05-21T15:23:53.838755Z","steps":["trace[1702121447] 'agreement among raft nodes before linearized reading'  (duration: 227.445004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:53.838966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:23:53.479805Z","time spent":"358.875154ms","remote":"127.0.0.1:38768","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:25073 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-21T15:23:54.138301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.043737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:54.138421Z","caller":"traceutil/trace.go:171","msg":"trace[129629251] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25090; }","duration":"257.219592ms","start":"2026-05-21T15:23:53.881175Z","end":"2026-05-21T15:23:54.138395Z","steps":["trace[129629251] 'count revisions from in-memory index tree'  (duration: 256.912734ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:23:56.435357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.749745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:23:56.435413Z","caller":"traceutil/trace.go:171","msg":"trace[1495130626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25108; }","duration":"136.848537ms","start":"2026-05-21T15:23:56.298552Z","end":"2026-05-21T15:23:56.4354Z","steps":["trace[1495130626] 'range keys from in-memory index tree'  (duration: 136.686073ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:56.442419Z","caller":"traceutil/trace.go:171","msg":"trace[290204351] transaction","detail":"{read_only:false; response_revision:25109; number_of_response:1; }","duration":"131.138581ms","start":"2026-05-21T15:23:56.31125Z","end":"2026-05-21T15:23:56.442388Z","steps":["trace[290204351] 'process raft request'  (duration: 130.944425ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:23:56.444581Z","caller":"traceutil/trace.go:171","msg":"trace[1098105224] transaction","detail":"{read_only:false; response_revision:25110; number_of_response:1; }","duration":"131.322086ms","start":"2026-05-21T15:23:56.313242Z","end":"2026-05-21T15:23:56.444564Z","steps":["trace[1098105224] 'process raft request'  (duration: 131.066369ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:00.83717Z","caller":"traceutil/trace.go:171","msg":"trace[703203108] linearizableReadLoop","detail":"{readStateIndex:25979; appliedIndex:25978; }","duration":"213.919824ms","start":"2026-05-21T15:24:00.623217Z","end":"2026-05-21T15:24:00.837137Z","steps":["trace[703203108] 'read index received'  (duration: 213.80284ms)","trace[703203108] 'applied index is now lower than readState.Index'  (duration: 115.744µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:00.837272Z","caller":"traceutil/trace.go:171","msg":"trace[578520335] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"221.563093ms","start":"2026-05-21T15:24:00.615665Z","end":"2026-05-21T15:24:00.837228Z","steps":["trace[578520335] 'process raft request'  (duration: 221.238574ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:00.837446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.17589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-21T15:24:00.837516Z","caller":"traceutil/trace.go:171","msg":"trace[636332295] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25160; }","duration":"214.320454ms","start":"2026-05-21T15:24:00.623172Z","end":"2026-05-21T15:24:00.837492Z","steps":["trace[636332295] 'agreement among raft nodes before linearized reading'  (duration: 214.109439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:00.850806Z","caller":"traceutil/trace.go:171","msg":"trace[15073808] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"227.478067ms","start":"2026-05-21T15:24:00.623308Z","end":"2026-05-21T15:24:00.850786Z","steps":["trace[15073808] 'process raft request'  (duration: 227.270951ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:00.850895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.635691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:00.850983Z","caller":"traceutil/trace.go:171","msg":"trace[446300371] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:25161; }","duration":"160.798596ms","start":"2026-05-21T15:24:00.690168Z","end":"2026-05-21T15:24:00.850966Z","steps":["trace[446300371] 'agreement among raft nodes before linearized reading'  (duration: 160.60182ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:01.134544Z","caller":"traceutil/trace.go:171","msg":"trace[67836495] transaction","detail":"{read_only:false; response_revision:25163; number_of_response:1; }","duration":"139.13767ms","start":"2026-05-21T15:24:00.995382Z","end":"2026-05-21T15:24:01.13452Z","steps":["trace[67836495] 'process raft request'  (duration: 139.085299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:01.134561Z","caller":"traceutil/trace.go:171","msg":"trace[1160404627] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"263.433042ms","start":"2026-05-21T15:24:00.871093Z","end":"2026-05-21T15:24:01.134526Z","steps":["trace[1160404627] 'process raft request'  (duration: 195.97387ms)","trace[1160404627] 'compare'  (duration: 67.252287ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:01.134796Z","caller":"traceutil/trace.go:171","msg":"trace[1629357978] linearizableReadLoop","detail":"{readStateIndex:25981; appliedIndex:25980; }","duration":"208.212446ms","start":"2026-05-21T15:24:00.926571Z","end":"2026-05-21T15:24:01.134784Z","steps":["trace[1629357978] 'read index received'  (duration: 140.508718ms)","trace[1629357978] 'applied index is now lower than readState.Index'  (duration: 67.702698ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:01.135177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.571575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-21T15:24:01.135265Z","caller":"traceutil/trace.go:171","msg":"trace[487750864] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25163; }","duration":"208.696479ms","start":"2026-05-21T15:24:00.926515Z","end":"2026-05-21T15:24:01.135211Z","steps":["trace[487750864] 'agreement among raft nodes before linearized reading'  (duration: 208.308608ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:01.368747Z","caller":"traceutil/trace.go:171","msg":"trace[756973807] transaction","detail":"{read_only:false; response_revision:25165; number_of_response:1; }","duration":"147.552822ms","start":"2026-05-21T15:24:01.22117Z","end":"2026-05-21T15:24:01.368722Z","steps":["trace[756973807] 'process raft request'  (duration: 147.238262ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:01.448305Z","caller":"traceutil/trace.go:171","msg":"trace[764490971] transaction","detail":"{read_only:false; response_revision:25166; number_of_response:1; }","duration":"226.404796ms","start":"2026-05-21T15:24:01.221867Z","end":"2026-05-21T15:24:01.448271Z","steps":["trace[764490971] 'process raft request'  (duration: 226.19611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:01.448643Z","caller":"traceutil/trace.go:171","msg":"trace[83877655] transaction","detail":"{read_only:false; response_revision:25168; number_of_response:1; }","duration":"103.301737ms","start":"2026-05-21T15:24:01.34532Z","end":"2026-05-21T15:24:01.448622Z","steps":["trace[83877655] 'process raft request'  (duration: 103.171673ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:01.448639Z","caller":"traceutil/trace.go:171","msg":"trace[545018638] transaction","detail":"{read_only:false; response_revision:25167; number_of_response:1; }","duration":"226.502299ms","start":"2026-05-21T15:24:01.222103Z","end":"2026-05-21T15:24:01.448605Z","steps":["trace[545018638] 'process raft request'  (duration: 226.126169ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:06.911601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.67045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274832"}
{"level":"info","ts":"2026-05-21T15:24:06.911659Z","caller":"traceutil/trace.go:171","msg":"trace[2138108724] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:25213; }","duration":"329.766284ms","start":"2026-05-21T15:24:06.58188Z","end":"2026-05-21T15:24:06.911646Z","steps":["trace[2138108724] 'range keys from in-memory index tree'  (duration: 329.372202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:06.911688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:24:06.581865Z","time spent":"329.815875ms","remote":"127.0.0.1:38924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":32,"response size":274855,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"warn","ts":"2026-05-21T15:24:07.091926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.348035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392884231 > lease_revoke:<id:47859e4af65438cb>","response":"size:29"}
{"level":"info","ts":"2026-05-21T15:24:07.09252Z","caller":"traceutil/trace.go:171","msg":"trace[1041146811] linearizableReadLoop","detail":"{readStateIndex:26034; appliedIndex:26033; }","duration":"239.312841ms","start":"2026-05-21T15:24:06.85318Z","end":"2026-05-21T15:24:07.092493Z","steps":["trace[1041146811] 'read index received'  (duration: 87.351639ms)","trace[1041146811] 'applied index is now lower than readState.Index'  (duration: 151.959452ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:07.09267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.482466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:07.092723Z","caller":"traceutil/trace.go:171","msg":"trace[1452985535] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:25213; }","duration":"239.585499ms","start":"2026-05-21T15:24:06.853125Z","end":"2026-05-21T15:24:07.092711Z","steps":["trace[1452985535] 'agreement among raft nodes before linearized reading'  (duration: 239.492696ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:07.092937Z","caller":"traceutil/trace.go:171","msg":"trace[2026453592] transaction","detail":"{read_only:false; response_revision:25214; number_of_response:1; }","duration":"237.46832ms","start":"2026-05-21T15:24:06.85544Z","end":"2026-05-21T15:24:07.092909Z","steps":["trace[2026453592] 'process raft request'  (duration: 236.935486ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:07.092974Z","caller":"traceutil/trace.go:171","msg":"trace[1397712561] transaction","detail":"{read_only:false; response_revision:25215; number_of_response:1; }","duration":"219.714693ms","start":"2026-05-21T15:24:06.873229Z","end":"2026-05-21T15:24:07.092944Z","steps":["trace[1397712561] 'process raft request'  (duration: 219.60176ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:07.332387Z","caller":"traceutil/trace.go:171","msg":"trace[1337436534] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"229.15387ms","start":"2026-05-21T15:24:07.103194Z","end":"2026-05-21T15:24:07.332348Z","steps":["trace[1337436534] 'process raft request'  (duration: 131.727166ms)","trace[1337436534] 'compare'  (duration: 97.177717ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:07.360727Z","caller":"traceutil/trace.go:171","msg":"trace[1289087463] linearizableReadLoop","detail":"{readStateIndex:26038; appliedIndex:26037; }","duration":"111.048469ms","start":"2026-05-21T15:24:07.249655Z","end":"2026-05-21T15:24:07.360703Z","steps":["trace[1289087463] 'read index received'  (duration: 110.782341ms)","trace[1289087463] 'applied index is now lower than readState.Index'  (duration: 264.928µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:07.360858Z","caller":"traceutil/trace.go:171","msg":"trace[1097433290] transaction","detail":"{read_only:false; response_revision:25217; number_of_response:1; }","duration":"207.344013ms","start":"2026-05-21T15:24:07.153478Z","end":"2026-05-21T15:24:07.360822Z","steps":["trace[1097433290] 'process raft request'  (duration: 207.074554ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:07.361123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.42437ms","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-21T15:24:07.361223Z","caller":"traceutil/trace.go:171","msg":"trace[1819324666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25217; }","duration":"111.591314ms","start":"2026-05-21T15:24:07.249611Z","end":"2026-05-21T15:24:07.361202Z","steps":["trace[1819324666] 'agreement among raft nodes before linearized reading'  (duration: 111.237244ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:26.042477Z","caller":"traceutil/trace.go:171","msg":"trace[284005700] linearizableReadLoop","detail":"{readStateIndex:26195; appliedIndex:26194; }","duration":"116.679163ms","start":"2026-05-21T15:24:25.925774Z","end":"2026-05-21T15:24:26.042453Z","steps":["trace[284005700] 'read index received'  (duration: 116.614671ms)","trace[284005700] 'applied index is now lower than readState.Index'  (duration: 63.632µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:26.042699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.91002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-21T15:24:26.04274Z","caller":"traceutil/trace.go:171","msg":"trace[1624486664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25371; }","duration":"117.001581ms","start":"2026-05-21T15:24:25.925728Z","end":"2026-05-21T15:24:26.04273Z","steps":["trace[1624486664] 'agreement among raft nodes before linearized reading'  (duration: 116.832307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:26.043068Z","caller":"traceutil/trace.go:171","msg":"trace[1210641442] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"129.725021ms","start":"2026-05-21T15:24:25.91333Z","end":"2026-05-21T15:24:26.043055Z","steps":["trace[1210641442] 'process raft request'  (duration: 129.001701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:26.232554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.146041ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392884626 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:25358 > 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-21T15:24:26.232742Z","caller":"traceutil/trace.go:171","msg":"trace[787481898] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"286.698981ms","start":"2026-05-21T15:24:25.94601Z","end":"2026-05-21T15:24:26.232709Z","steps":["trace[787481898] 'process raft request'  (duration: 147.254982ms)","trace[787481898] 'compare'  (duration: 138.418671ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:26.232929Z","caller":"traceutil/trace.go:171","msg":"trace[730099849] transaction","detail":"{read_only:false; response_revision:25373; number_of_response:1; }","duration":"185.887104ms","start":"2026-05-21T15:24:26.047016Z","end":"2026-05-21T15:24:26.232903Z","steps":["trace[730099849] 'process raft request'  (duration: 185.704429ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:26.233154Z","caller":"traceutil/trace.go:171","msg":"trace[2127400432] linearizableReadLoop","detail":"{readStateIndex:26196; appliedIndex:26195; }","duration":"186.205282ms","start":"2026-05-21T15:24:26.046925Z","end":"2026-05-21T15:24:26.23313Z","steps":["trace[2127400432] 'read index received'  (duration: 46.423384ms)","trace[2127400432] 'applied index is now lower than readState.Index'  (duration: 139.780068ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:26.233159Z","caller":"traceutil/trace.go:171","msg":"trace[781052130] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"164.916038ms","start":"2026-05-21T15:24:26.068212Z","end":"2026-05-21T15:24:26.233128Z","steps":["trace[781052130] 'process raft request'  (duration: 164.581039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:26.233322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.356196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:26.233389Z","caller":"traceutil/trace.go:171","msg":"trace[8102523] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:25374; }","duration":"186.448829ms","start":"2026-05-21T15:24:26.046907Z","end":"2026-05-21T15:24:26.233356Z","steps":["trace[8102523] 'agreement among raft nodes before linearized reading'  (duration: 186.293015ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:26.555541Z","caller":"traceutil/trace.go:171","msg":"trace[361759801] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"165.539875ms","start":"2026-05-21T15:24:26.389981Z","end":"2026-05-21T15:24:26.555521Z","steps":["trace[361759801] 'process raft request'  (duration: 165.400291ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:27.162789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.694479ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392884637 > lease_revoke:<id:47859e4af6543a59>","response":"size:29"}
{"level":"info","ts":"2026-05-21T15:24:27.163049Z","caller":"traceutil/trace.go:171","msg":"trace[1495246813] linearizableReadLoop","detail":"{readStateIndex:26203; appliedIndex:26202; }","duration":"295.02603ms","start":"2026-05-21T15:24:26.867993Z","end":"2026-05-21T15:24:27.163019Z","steps":["trace[1495246813] 'read index received'  (duration: 85.981671ms)","trace[1495246813] 'applied index is now lower than readState.Index'  (duration: 209.041379ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:27.163167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.143483ms","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-21T15:24:27.163201Z","caller":"traceutil/trace.go:171","msg":"trace[1627487220] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25378; }","duration":"295.250236ms","start":"2026-05-21T15:24:26.867939Z","end":"2026-05-21T15:24:27.163189Z","steps":["trace[1627487220] 'agreement among raft nodes before linearized reading'  (duration: 295.143213ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:27.28553Z","caller":"traceutil/trace.go:171","msg":"trace[684772650] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"121.733992ms","start":"2026-05-21T15:24:27.163762Z","end":"2026-05-21T15:24:27.285496Z","steps":["trace[684772650] 'process raft request'  (duration: 121.466654ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:27.298077Z","caller":"traceutil/trace.go:171","msg":"trace[1825461367] transaction","detail":"{read_only:false; response_revision:25380; number_of_response:1; }","duration":"131.388496ms","start":"2026-05-21T15:24:27.166671Z","end":"2026-05-21T15:24:27.298059Z","steps":["trace[1825461367] 'process raft request'  (duration: 131.15285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:27.673986Z","caller":"traceutil/trace.go:171","msg":"trace[2082738272] linearizableReadLoop","detail":"{readStateIndex:26206; appliedIndex:26205; }","duration":"208.148925ms","start":"2026-05-21T15:24:27.465813Z","end":"2026-05-21T15:24:27.673962Z","steps":["trace[2082738272] 'read index received'  (duration: 207.94501ms)","trace[2082738272] 'applied index is now lower than readState.Index'  (duration: 202.585µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:27.674048Z","caller":"traceutil/trace.go:171","msg":"trace[1521694473] transaction","detail":"{read_only:false; response_revision:25381; number_of_response:1; }","duration":"253.963293ms","start":"2026-05-21T15:24:27.420054Z","end":"2026-05-21T15:24:27.674017Z","steps":["trace[1521694473] 'process raft request'  (duration: 253.765897ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:27.674226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.379631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-21T15:24:27.674299Z","caller":"traceutil/trace.go:171","msg":"trace[1931902514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25381; }","duration":"208.503565ms","start":"2026-05-21T15:24:27.465782Z","end":"2026-05-21T15:24:27.674286Z","steps":["trace[1931902514] 'agreement among raft nodes before linearized reading'  (duration: 208.29785ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:27.674327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.669763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-21T15:24:27.674392Z","caller":"traceutil/trace.go:171","msg":"trace[981925958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25381; }","duration":"171.781087ms","start":"2026-05-21T15:24:27.502597Z","end":"2026-05-21T15:24:27.674378Z","steps":["trace[981925958] 'agreement among raft nodes before linearized reading'  (duration: 171.54779ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:28.399581Z","caller":"traceutil/trace.go:171","msg":"trace[261215462] transaction","detail":"{read_only:false; response_revision:25387; number_of_response:1; }","duration":"160.829506ms","start":"2026-05-21T15:24:28.238729Z","end":"2026-05-21T15:24:28.399559Z","steps":["trace[261215462] 'process raft request'  (duration: 160.711432ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:28.581814Z","caller":"traceutil/trace.go:171","msg":"trace[907593018] transaction","detail":"{read_only:false; response_revision:25388; number_of_response:1; }","duration":"247.837365ms","start":"2026-05-21T15:24:28.333931Z","end":"2026-05-21T15:24:28.581769Z","steps":["trace[907593018] 'process raft request'  (duration: 157.854805ms)","trace[907593018] 'compare'  (duration: 89.844946ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:28.629925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.334324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:28.630038Z","caller":"traceutil/trace.go:171","msg":"trace[740338260] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:25389; }","duration":"112.502038ms","start":"2026-05-21T15:24:28.517516Z","end":"2026-05-21T15:24:28.630018Z","steps":["trace[740338260] 'agreement among raft nodes before linearized reading'  (duration: 112.086597ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:29.023934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.513892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:29.024012Z","caller":"traceutil/trace.go:171","msg":"trace[1781891394] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:25391; }","duration":"327.644656ms","start":"2026-05-21T15:24:28.696346Z","end":"2026-05-21T15:24:29.023991Z","steps":["trace[1781891394] 'count revisions from in-memory index tree'  (duration: 327.43406ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:29.024052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:24:28.696324Z","time spent":"327.717167ms","remote":"127.0.0.1:42824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-05-21T15:24:29.446756Z","caller":"traceutil/trace.go:171","msg":"trace[1869600386] linearizableReadLoop","detail":"{readStateIndex:26217; appliedIndex:26216; }","duration":"147.91884ms","start":"2026-05-21T15:24:29.298814Z","end":"2026-05-21T15:24:29.446733Z","steps":["trace[1869600386] 'read index received'  (duration: 147.810067ms)","trace[1869600386] 'applied index is now lower than readState.Index'  (duration: 107.693µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:29.446901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.069085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:29.44694Z","caller":"traceutil/trace.go:171","msg":"trace[242356051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25392; }","duration":"148.154387ms","start":"2026-05-21T15:24:29.298775Z","end":"2026-05-21T15:24:29.446929Z","steps":["trace[242356051] 'agreement among raft nodes before linearized reading'  (duration: 148.049215ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:29.446997Z","caller":"traceutil/trace.go:171","msg":"trace[944462129] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"155.789748ms","start":"2026-05-21T15:24:29.291165Z","end":"2026-05-21T15:24:29.446954Z","steps":["trace[944462129] 'process raft request'  (duration: 155.429887ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:29.524608Z","caller":"traceutil/trace.go:171","msg":"trace[1579975776] transaction","detail":"{read_only:false; response_revision:25393; number_of_response:1; }","duration":"221.268175ms","start":"2026-05-21T15:24:29.303323Z","end":"2026-05-21T15:24:29.524591Z","steps":["trace[1579975776] 'process raft request'  (duration: 220.994227ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:32.803449Z","caller":"traceutil/trace.go:171","msg":"trace[1423977853] transaction","detail":"{read_only:false; response_revision:25419; number_of_response:1; }","duration":"145.794473ms","start":"2026-05-21T15:24:32.657628Z","end":"2026-05-21T15:24:32.803422Z","steps":["trace[1423977853] 'process raft request'  (duration: 145.576137ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:32.803586Z","caller":"traceutil/trace.go:171","msg":"trace[1354195665] transaction","detail":"{read_only:false; response_revision:25420; number_of_response:1; }","duration":"143.8675ms","start":"2026-05-21T15:24:32.659685Z","end":"2026-05-21T15:24:32.803552Z","steps":["trace[1354195665] 'process raft request'  (duration: 143.681245ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:34.239625Z","caller":"traceutil/trace.go:171","msg":"trace[904575678] transaction","detail":"{read_only:false; response_revision:25429; number_of_response:1; }","duration":"154.08702ms","start":"2026-05-21T15:24:34.085506Z","end":"2026-05-21T15:24:34.239593Z","steps":["trace[904575678] 'process raft request'  (duration: 153.903505ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:34.407155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.756448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:34.40725Z","caller":"traceutil/trace.go:171","msg":"trace[60342878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25429; }","duration":"107.964834ms","start":"2026-05-21T15:24:34.299266Z","end":"2026-05-21T15:24:34.407231Z","steps":["trace[60342878] 'range keys from in-memory index tree'  (duration: 107.661276ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:34.656953Z","caller":"traceutil/trace.go:171","msg":"trace[1402079351] transaction","detail":"{read_only:false; response_revision:25430; number_of_response:1; }","duration":"197.07015ms","start":"2026-05-21T15:24:34.459854Z","end":"2026-05-21T15:24:34.656924Z","steps":["trace[1402079351] 'process raft request'  (duration: 196.829434ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:39.606392Z","caller":"traceutil/trace.go:171","msg":"trace[37969146] transaction","detail":"{read_only:false; response_revision:25466; number_of_response:1; }","duration":"130.73506ms","start":"2026-05-21T15:24:39.475638Z","end":"2026-05-21T15:24:39.606373Z","steps":["trace[37969146] 'process raft request'  (duration: 120.969532ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:45.051566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.275759ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392884950 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25492 > 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:18"}
{"level":"info","ts":"2026-05-21T15:24:45.052193Z","caller":"traceutil/trace.go:171","msg":"trace[849726903] transaction","detail":"{read_only:false; response_revision:25511; number_of_response:1; }","duration":"208.129494ms","start":"2026-05-21T15:24:44.843752Z","end":"2026-05-21T15:24:45.051881Z","steps":["trace[849726903] 'process raft request'  (duration: 97.391804ms)","trace[849726903] 'compare'  (duration: 109.960809ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:45.052586Z","caller":"traceutil/trace.go:171","msg":"trace[859352155] linearizableReadLoop","detail":"{readStateIndex:26340; appliedIndex:26338; }","duration":"161.870855ms","start":"2026-05-21T15:24:44.890681Z","end":"2026-05-21T15:24:45.052552Z","steps":["trace[859352155] 'read index received'  (duration: 50.431165ms)","trace[859352155] 'applied index is now lower than readState.Index'  (duration: 111.438339ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:45.052665Z","caller":"traceutil/trace.go:171","msg":"trace[387400534] transaction","detail":"{read_only:false; response_revision:25512; number_of_response:1; }","duration":"208.7068ms","start":"2026-05-21T15:24:44.843923Z","end":"2026-05-21T15:24:45.052629Z","steps":["trace[387400534] 'process raft request'  (duration: 207.783615ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:45.052905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.146039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-05-21T15:24:45.052916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.220994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-registry-c45778976-7kqxf\" ","response":"range_response_count:1 size:3397"}
{"level":"info","ts":"2026-05-21T15:24:45.052963Z","caller":"traceutil/trace.go:171","msg":"trace[362075535] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25512; }","duration":"139.256422ms","start":"2026-05-21T15:24:44.913692Z","end":"2026-05-21T15:24:45.052948Z","steps":["trace[362075535] 'agreement among raft nodes before linearized reading'  (duration: 139.085238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:45.052977Z","caller":"traceutil/trace.go:171","msg":"trace[1400880176] range","detail":"{range_begin:/registry/pods/openstack/magnum-registry-c45778976-7kqxf; range_end:; response_count:1; response_revision:25512; }","duration":"162.334127ms","start":"2026-05-21T15:24:44.890624Z","end":"2026-05-21T15:24:45.052959Z","steps":["trace[1400880176] 'agreement among raft nodes before linearized reading'  (duration: 162.10722ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:45.355021Z","caller":"traceutil/trace.go:171","msg":"trace[733880349] linearizableReadLoop","detail":"{readStateIndex:26341; appliedIndex:26340; }","duration":"237.123219ms","start":"2026-05-21T15:24:45.117871Z","end":"2026-05-21T15:24:45.354994Z","steps":["trace[733880349] 'read index received'  (duration: 236.836191ms)","trace[733880349] 'applied index is now lower than readState.Index'  (duration: 285.868µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:45.355352Z","caller":"traceutil/trace.go:171","msg":"trace[239517540] transaction","detail":"{read_only:false; response_revision:25513; number_of_response:1; }","duration":"291.528054ms","start":"2026-05-21T15:24:45.063798Z","end":"2026-05-21T15:24:45.355326Z","steps":["trace[239517540] 'process raft request'  (duration: 291.0109ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:45.41409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.696229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:45.414208Z","caller":"traceutil/trace.go:171","msg":"trace[258819875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25513; }","duration":"114.874334ms","start":"2026-05-21T15:24:45.299305Z","end":"2026-05-21T15:24:45.41418Z","steps":["trace[258819875] 'agreement among raft nodes before linearized reading'  (duration: 56.426449ms)","trace[258819875] 'range keys from in-memory index tree'  (duration: 58.280651ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:45.414454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.545201ms","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-21T15:24:45.414635Z","caller":"traceutil/trace.go:171","msg":"trace[863871819] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25513; }","duration":"296.748296ms","start":"2026-05-21T15:24:45.117808Z","end":"2026-05-21T15:24:45.414557Z","steps":["trace[863871819] 'agreement among raft nodes before linearized reading'  (duration: 237.484009ms)","trace[863871819] 'range keys from in-memory index tree'  (duration: 59.02451ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:45.565934Z","caller":"traceutil/trace.go:171","msg":"trace[936721580] linearizableReadLoop","detail":"{readStateIndex:26343; appliedIndex:26342; }","duration":"150.017678ms","start":"2026-05-21T15:24:45.415875Z","end":"2026-05-21T15:24:45.565892Z","steps":["trace[936721580] 'read index received'  (duration: 141.059373ms)","trace[936721580] 'applied index is now lower than readState.Index'  (duration: 8.956295ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:45.565952Z","caller":"traceutil/trace.go:171","msg":"trace[1240064173] transaction","detail":"{read_only:false; response_revision:25515; number_of_response:1; }","duration":"204.627068ms","start":"2026-05-21T15:24:45.361287Z","end":"2026-05-21T15:24:45.565914Z","steps":["trace[1240064173] 'process raft request'  (duration: 195.649752ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:45.566077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.169013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:45.566156Z","caller":"traceutil/trace.go:171","msg":"trace[1726217027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25515; }","duration":"150.312268ms","start":"2026-05-21T15:24:45.415821Z","end":"2026-05-21T15:24:45.566134Z","steps":["trace[1726217027] 'agreement among raft nodes before linearized reading'  (duration: 150.149232ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:45.566273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.641577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:45.566315Z","caller":"traceutil/trace.go:171","msg":"trace[485268093] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25515; }","duration":"146.76612ms","start":"2026-05-21T15:24:45.419536Z","end":"2026-05-21T15:24:45.566302Z","steps":["trace[485268093] 'agreement among raft nodes before linearized reading'  (duration: 146.569265ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:55.897583Z","caller":"traceutil/trace.go:171","msg":"trace[55056421] transaction","detail":"{read_only:false; response_revision:25596; number_of_response:1; }","duration":"206.747836ms","start":"2026-05-21T15:24:55.690811Z","end":"2026-05-21T15:24:55.897559Z","steps":["trace[55056421] 'process raft request'  (duration: 206.579271ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:55.982134Z","caller":"traceutil/trace.go:171","msg":"trace[493290751] transaction","detail":"{read_only:false; response_revision:25597; number_of_response:1; }","duration":"291.188795ms","start":"2026-05-21T15:24:55.690917Z","end":"2026-05-21T15:24:55.982106Z","steps":["trace[493290751] 'process raft request'  (duration: 278.64551ms)","trace[493290751] 'compare'  (duration: 12.370141ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:55.982377Z","caller":"traceutil/trace.go:171","msg":"trace[1848754621] linearizableReadLoop","detail":"{readStateIndex:26428; appliedIndex:26425; }","duration":"197.555994ms","start":"2026-05-21T15:24:55.784794Z","end":"2026-05-21T15:24:55.982349Z","steps":["trace[1848754621] 'read index received'  (duration: 112.696303ms)","trace[1848754621] 'applied index is now lower than readState.Index'  (duration: 84.857651ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T15:24:55.982656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.845922ms","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-21T15:24:55.982725Z","caller":"traceutil/trace.go:171","msg":"trace[366050262] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25598; }","duration":"197.959466ms","start":"2026-05-21T15:24:55.784749Z","end":"2026-05-21T15:24:55.982709Z","steps":["trace[366050262] 'agreement among raft nodes before linearized reading'  (duration: 197.840092ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:55.9829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.739803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-21T15:24:55.982979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.321865ms","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-21T15:24:55.98308Z","caller":"traceutil/trace.go:171","msg":"trace[1694595945] 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:25598; }","duration":"108.472508ms","start":"2026-05-21T15:24:55.87459Z","end":"2026-05-21T15:24:55.983063Z","steps":["trace[1694595945] 'agreement among raft nodes before linearized reading'  (duration: 108.261693ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:55.982953Z","caller":"traceutil/trace.go:171","msg":"trace[1061005724] transaction","detail":"{read_only:false; response_revision:25598; number_of_response:1; }","duration":"207.013273ms","start":"2026-05-21T15:24:55.775909Z","end":"2026-05-21T15:24:55.982922Z","steps":["trace[1061005724] 'process raft request'  (duration: 206.15453ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:55.983083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.971579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-05-21T15:24:55.982801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.405358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-21T15:24:55.983Z","caller":"traceutil/trace.go:171","msg":"trace[935567275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25598; }","duration":"109.864836ms","start":"2026-05-21T15:24:55.873116Z","end":"2026-05-21T15:24:55.982981Z","steps":["trace[935567275] 'agreement among raft nodes before linearized reading'  (duration: 109.599769ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:55.983157Z","caller":"traceutil/trace.go:171","msg":"trace[678063639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25598; }","duration":"110.066101ms","start":"2026-05-21T15:24:55.873071Z","end":"2026-05-21T15:24:55.983137Z","steps":["trace[678063639] 'agreement among raft nodes before linearized reading'  (duration: 109.874736ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:55.983171Z","caller":"traceutil/trace.go:171","msg":"trace[652388488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25598; }","duration":"115.82325ms","start":"2026-05-21T15:24:55.867331Z","end":"2026-05-21T15:24:55.983154Z","steps":["trace[652388488] 'agreement among raft nodes before linearized reading'  (duration: 115.335197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:55.983301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.491823ms","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-21T15:24:55.983451Z","caller":"traceutil/trace.go:171","msg":"trace[1127522773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25598; }","duration":"110.661727ms","start":"2026-05-21T15:24:55.872777Z","end":"2026-05-21T15:24:55.983439Z","steps":["trace[1127522773] 'agreement among raft nodes before linearized reading'  (duration: 110.253106ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:56.246628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.044265ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153699393392885145 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25586 > 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-21T15:24:56.246809Z","caller":"traceutil/trace.go:171","msg":"trace[1709372289] transaction","detail":"{read_only:false; response_revision:25599; number_of_response:1; }","duration":"260.163003ms","start":"2026-05-21T15:24:55.986626Z","end":"2026-05-21T15:24:56.246789Z","steps":["trace[1709372289] 'process raft request'  (duration: 115.863972ms)","trace[1709372289] 'compare'  (duration: 143.90089ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:56.253918Z","caller":"traceutil/trace.go:171","msg":"trace[2028360959] linearizableReadLoop","detail":"{readStateIndex:26432; appliedIndex:26428; }","duration":"265.17081ms","start":"2026-05-21T15:24:55.98873Z","end":"2026-05-21T15:24:56.253901Z","steps":["trace[2028360959] 'read index received'  (duration: 113.795154ms)","trace[2028360959] 'applied index is now lower than readState.Index'  (duration: 151.374856ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:24:56.254008Z","caller":"traceutil/trace.go:171","msg":"trace[1073899270] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"266.222789ms","start":"2026-05-21T15:24:55.987777Z","end":"2026-05-21T15:24:56.254Z","steps":["trace[1073899270] 'process raft request'  (duration: 266.101446ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:56.254026Z","caller":"traceutil/trace.go:171","msg":"trace[428271176] transaction","detail":"{read_only:false; response_revision:25601; number_of_response:1; }","duration":"266.378463ms","start":"2026-05-21T15:24:55.987618Z","end":"2026-05-21T15:24:56.253996Z","steps":["trace[428271176] 'process raft request'  (duration: 266.233659ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:56.253963Z","caller":"traceutil/trace.go:171","msg":"trace[1048517141] transaction","detail":"{read_only:false; response_revision:25600; number_of_response:1; }","duration":"267.194846ms","start":"2026-05-21T15:24:55.986737Z","end":"2026-05-21T15:24:56.253932Z","steps":["trace[1048517141] 'process raft request'  (duration: 267.025332ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:56.254243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.672553ms","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":"warn","ts":"2026-05-21T15:24:56.254234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.473978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-21T15:24:56.254305Z","caller":"traceutil/trace.go:171","msg":"trace[429313416] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25602; }","duration":"112.782156ms","start":"2026-05-21T15:24:56.141506Z","end":"2026-05-21T15:24:56.254288Z","steps":["trace[429313416] 'agreement among raft nodes before linearized reading'  (duration: 112.676553ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T15:24:56.254322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.855582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-05-21T15:24:56.25432Z","caller":"traceutil/trace.go:171","msg":"trace[1890353569] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25602; }","duration":"265.602272ms","start":"2026-05-21T15:24:55.9887Z","end":"2026-05-21T15:24:56.254302Z","steps":["trace[1890353569] 'agreement among raft nodes before linearized reading'  (duration: 265.458418ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:56.254409Z","caller":"traceutil/trace.go:171","msg":"trace[970702429] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25602; }","duration":"264.968905ms","start":"2026-05-21T15:24:55.9894Z","end":"2026-05-21T15:24:56.254369Z","steps":["trace[970702429] 'agreement among raft nodes before linearized reading'  (duration: 264.633756ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T15:24:56.417678Z","caller":"traceutil/trace.go:171","msg":"trace[1464848330] transaction","detail":"{read_only:false; response_revision:25603; number_of_response:1; }","duration":"141.463034ms","start":"2026-05-21T15:24:56.276186Z","end":"2026-05-21T15:24:56.417649Z","steps":["trace[1464848330] 'process raft request'  (duration: 129.780613ms)","trace[1464848330] 'compare'  (duration: 11.531737ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:25:11.462404Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006862.wal"}
{"level":"info","ts":"2026-05-21T15:25:18.362881Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22942}
{"level":"info","ts":"2026-05-21T15:25:18.494064Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22942,"took":"127.133171ms","hash":2273500020,"current-db-size-bytes":59305984,"current-db-size":"59 MB","current-db-size-in-use-bytes":35446784,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-21T15:25:18.494132Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2273500020,"revision":22942,"compact-revision":20048}
{"level":"info","ts":"2026-05-21T15:28:05.976455Z","caller":"traceutil/trace.go:171","msg":"trace[1707028281] transaction","detail":"{read_only:false; response_revision:27541; number_of_response:1; }","duration":"130.267946ms","start":"2026-05-21T15:28:05.846149Z","end":"2026-05-21T15:28:05.976417Z","steps":["trace[1707028281] 'process raft request'  (duration: 31.863774ms)","trace[1707028281] 'compare'  (duration: 98.236677ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:28:24.072711Z","caller":"traceutil/trace.go:171","msg":"trace[1025580085] transaction","detail":"{read_only:false; response_revision:27775; number_of_response:1; }","duration":"142.424861ms","start":"2026-05-21T15:28:23.930259Z","end":"2026-05-21T15:28:24.072684Z","steps":["trace[1025580085] 'process raft request'  (duration: 78.270899ms)","trace[1025580085] 'compare'  (duration: 64.023128ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:30:18.372415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25944}
{"level":"info","ts":"2026-05-21T15:30:18.514956Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25944,"took":"138.833812ms","hash":2417821756,"current-db-size-bytes":59305984,"current-db-size":"59 MB","current-db-size-in-use-bytes":34717696,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-21T15:30:18.515048Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2417821756,"revision":25944,"compact-revision":22942}
{"level":"info","ts":"2026-05-21T15:31:13.32112Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-21T15:31:13.329551Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-21T15:31:13.329816Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-21T15:35:18.378996Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28677}
{"level":"info","ts":"2026-05-21T15:35:18.515448Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28677,"took":"132.390824ms","hash":1688604039,"current-db-size-bytes":59305984,"current-db-size":"59 MB","current-db-size-in-use-bytes":30334976,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-21T15:35:18.515524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1688604039,"revision":28677,"compact-revision":25944}
{"level":"info","ts":"2026-05-21T15:40:18.38457Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30900}
{"level":"info","ts":"2026-05-21T15:40:18.495426Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30900,"took":"107.471741ms","hash":2719469247,"current-db-size-bytes":59305984,"current-db-size":"59 MB","current-db-size-in-use-bytes":31277056,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-21T15:40:18.495524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2719469247,"revision":30900,"compact-revision":28677}
{"level":"info","ts":"2026-05-21T15:42:40.023258Z","caller":"traceutil/trace.go:171","msg":"trace[2086550669] transaction","detail":"{read_only:false; response_revision:34259; number_of_response:1; }","duration":"101.374543ms","start":"2026-05-21T15:42:39.921839Z","end":"2026-05-21T15:42:40.023214Z","steps":["trace[2086550669] 'process raft request'  (duration: 73.879829ms)","trace[2086550669] 'compare'  (duration: 27.254118ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T15:45:18.392093Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33166}
{"level":"info","ts":"2026-05-21T15:45:18.557461Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33166,"took":"151.516834ms","hash":2018489864,"current-db-size-bytes":60350464,"current-db-size":"60 MB","current-db-size-in-use-bytes":31797248,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-21T15:45:18.55754Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2018489864,"revision":33166,"compact-revision":30900}
{"level":"info","ts":"2026-05-21T15:50:18.399641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35458}
{"level":"info","ts":"2026-05-21T15:50:18.542276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35458,"took":"139.666529ms","hash":2359930233,"current-db-size-bytes":60350464,"current-db-size":"60 MB","current-db-size-in-use-bytes":31432704,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-21T15:50:18.542366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2359930233,"revision":35458,"compact-revision":33166}
{"level":"info","ts":"2026-05-21T15:52:42.338471Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-21T15:52:42.344992Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-21T15:52:42.345157Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-21T15:55:18.404782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37692}
{"level":"info","ts":"2026-05-21T15:55:18.524349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37692,"took":"116.151903ms","hash":1574236887,"current-db-size-bytes":60350464,"current-db-size":"60 MB","current-db-size-in-use-bytes":31088640,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-21T15:55:18.52442Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1574236887,"revision":37692,"compact-revision":35458}