{"level":"warn","ts":"2026-05-08T23:10:53.93379Z","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-08T23:10:53.933883Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-08T23:10:53.93396Z","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-08T23:10:53.933976Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]}
{"level":"info","ts":"2026-05-08T23:10:53.933995Z","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-08T23:10:53.934636Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]}
{"level":"info","ts":"2026-05-08T23:10:53.934734Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-08T23:10:53.938781Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.821383ms"}
{"level":"info","ts":"2026-05-08T23:10:53.945369Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"}
{"level":"info","ts":"2026-05-08T23:10:53.945512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"}
{"level":"info","ts":"2026-05-08T23:10:53.94555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"}
{"level":"info","ts":"2026-05-08T23:10:53.945575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-08T23:10:53.945591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"}
{"level":"info","ts":"2026-05-08T23:10:53.945663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"}
{"level":"warn","ts":"2026-05-08T23:10:53.951103Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-08T23:10:53.95258Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-08T23:10:53.953654Z","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-08T23:10:53.956522Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-08T23:10:53.956716Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-08T23:10:53.95708Z","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-08T23:10:53.957172Z","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-08T23:10:53.95762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"}
{"level":"info","ts":"2026-05-08T23:10:53.957488Z","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-08T23:10:53.957735Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]}
{"level":"info","ts":"2026-05-08T23:10:53.963391Z","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-08T23:10:53.963519Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"}
{"level":"info","ts":"2026-05-08T23:10:53.963561Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"}
{"level":"info","ts":"2026-05-08T23:10:53.963876Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-08T23:10:53.963913Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-08T23:10:54.946493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"}
{"level":"info","ts":"2026-05-08T23:10:54.946588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-08T23:10:54.946621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"}
{"level":"info","ts":"2026-05-08T23:10:54.946649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.946664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.946688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.946707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"}
{"level":"info","ts":"2026-05-08T23:10:54.947901Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.948892Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-08T23:10:54.948897Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T23:10:54.948969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T23:10:54.94962Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.949799Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.949859Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T23:10:54.949416Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-08T23:10:54.950525Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-08T23:10:54.95118Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-08T23:10:54.952968Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"}
{"level":"info","ts":"2026-05-08T23:10:59.647581Z","caller":"traceutil/trace.go:171","msg":"trace[2085477091] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"182.727494ms","start":"2026-05-08T23:10:59.464819Z","end":"2026-05-08T23:10:59.647547Z","steps":["trace[2085477091] 'process raft request'  (duration: 182.505599ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:11:08.643832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.370946ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921392785 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:397 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T23:11:08.643975Z","caller":"traceutil/trace.go:171","msg":"trace[560462568] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"102.867901ms","start":"2026-05-08T23:11:08.541085Z","end":"2026-05-08T23:11:08.643953Z","steps":["trace[560462568] 'read index received'  (duration: 45.011µs)","trace[560462568] 'applied index is now lower than readState.Index'  (duration: 102.82134ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:11:08.644042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.965694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:11:08.644074Z","caller":"traceutil/trace.go:171","msg":"trace[1577764998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"103.053305ms","start":"2026-05-08T23:11:08.541011Z","end":"2026-05-08T23:11:08.644065Z","steps":["trace[1577764998] 'agreement among raft nodes before linearized reading'  (duration: 102.995234ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:11:08.644057Z","caller":"traceutil/trace.go:171","msg":"trace[1119460968] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"206.594652ms","start":"2026-05-08T23:11:08.437412Z","end":"2026-05-08T23:11:08.644006Z","steps":["trace[1119460968] 'process raft request'  (duration: 68.361345ms)","trace[1119460968] 'compare'  (duration: 137.215633ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:11:30.768863Z","caller":"traceutil/trace.go:171","msg":"trace[2022773461] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"229.963932ms","start":"2026-05-08T23:11:30.538882Z","end":"2026-05-08T23:11:30.768846Z","steps":["trace[2022773461] 'process raft request'  (duration: 229.811888ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:11:30.803881Z","caller":"traceutil/trace.go:171","msg":"trace[1127577354] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"227.176543ms","start":"2026-05-08T23:11:30.576672Z","end":"2026-05-08T23:11:30.803848Z","steps":["trace[1127577354] 'process raft request'  (duration: 226.707322ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:11:32.111142Z","caller":"traceutil/trace.go:171","msg":"trace[1870103431] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"210.552375ms","start":"2026-05-08T23:11:31.900538Z","end":"2026-05-08T23:11:32.11109Z","steps":["trace[1870103431] 'process raft request'  (duration: 210.266998ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:11:32.677961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.716922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-08T23:11:32.678288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.046756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nbznt\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-05-08T23:11:32.678399Z","caller":"traceutil/trace.go:171","msg":"trace[1102082365] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nbznt; range_end:; response_count:1; response_revision:622; }","duration":"389.161338ms","start":"2026-05-08T23:11:32.289184Z","end":"2026-05-08T23:11:32.678345Z","steps":["trace[1102082365] 'range keys from in-memory index tree'  (duration: 388.844079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:11:32.678513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:11:32.289155Z","time spent":"389.340422ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-nbznt\" "}
{"level":"info","ts":"2026-05-08T23:11:32.67862Z","caller":"traceutil/trace.go:171","msg":"trace[34602435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"139.40615ms","start":"2026-05-08T23:11:32.539192Z","end":"2026-05-08T23:11:32.678598Z","steps":["trace[34602435] 'range keys from in-memory index tree'  (duration: 138.652601ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:11:32.687399Z","caller":"traceutil/trace.go:171","msg":"trace[1151097571] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"110.892521ms","start":"2026-05-08T23:11:32.576461Z","end":"2026-05-08T23:11:32.687353Z","steps":["trace[1151097571] 'process raft request'  (duration: 110.244545ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:12:59.759046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.567447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:12:59.759188Z","caller":"traceutil/trace.go:171","msg":"trace[1034725578] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1838; }","duration":"100.764732ms","start":"2026-05-08T23:12:59.658402Z","end":"2026-05-08T23:12:59.759166Z","steps":["trace[1034725578] 'count revisions from in-memory index tree'  (duration: 100.396603ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:12:59.759181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.071109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:12:59.759269Z","caller":"traceutil/trace.go:171","msg":"trace[908111509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"218.204672ms","start":"2026-05-08T23:12:59.541042Z","end":"2026-05-08T23:12:59.759246Z","steps":["trace[908111509] 'range keys from in-memory index tree'  (duration: 217.917076ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:12:59.75936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.559042ms","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-08T23:12:59.759416Z","caller":"traceutil/trace.go:171","msg":"trace[914177037] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1838; }","duration":"312.649194ms","start":"2026-05-08T23:12:59.446753Z","end":"2026-05-08T23:12:59.759402Z","steps":["trace[914177037] 'range keys from in-memory index tree'  (duration: 312.423029ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:12:59.759457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.446736Z","time spent":"312.709306ms","remote":"127.0.0.1:50566","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-08T23:12:59.759443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.449872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a6b66ce-e9da-4ea0-a286-3e81806225fe\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-08T23:12:59.759504Z","caller":"traceutil/trace.go:171","msg":"trace[1503133712] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a6b66ce-e9da-4ea0-a286-3e81806225fe; range_end:; response_count:1; response_revision:1838; }","duration":"181.547766ms","start":"2026-05-08T23:12:59.577942Z","end":"2026-05-08T23:12:59.75949Z","steps":["trace[1503133712] 'range keys from in-memory index tree'  (duration: 181.237368ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:00.177639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.435244ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921395608 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-4t4kp\" mod_revision:1811 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-4t4kp\" value_size:1390 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-4t4kp\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T23:13:00.177876Z","caller":"traceutil/trace.go:171","msg":"trace[1678772806] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"370.815627ms","start":"2026-05-08T23:12:59.807027Z","end":"2026-05-08T23:13:00.177843Z","steps":["trace[1678772806] 'process raft request'  (duration: 82.094096ms)","trace[1678772806] 'compare'  (duration: 287.988374ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:13:00.178036Z","caller":"traceutil/trace.go:171","msg":"trace[1382141252] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"370.1363ms","start":"2026-05-08T23:12:59.807874Z","end":"2026-05-08T23:13:00.17801Z","steps":["trace[1382141252] 'process raft request'  (duration: 369.960336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:00.178137Z","caller":"traceutil/trace.go:171","msg":"trace[647769308] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"370.432517ms","start":"2026-05-08T23:12:59.807517Z","end":"2026-05-08T23:13:00.177949Z","steps":["trace[647769308] 'process raft request'  (duration: 370.237712ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:00.178169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.807855Z","time spent":"370.239142ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":976,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" mod_revision:1806 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" value_size:907 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" > >"}
{"level":"warn","ts":"2026-05-08T23:13:00.17824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.807505Z","time spent":"370.693174ms","remote":"127.0.0.1:50570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1528,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-pvzsl\" mod_revision:1807 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-pvzsl\" value_size:1457 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-pvzsl\" > >"}
{"level":"info","ts":"2026-05-08T23:13:00.178506Z","caller":"traceutil/trace.go:171","msg":"trace[450732238] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"368.02992ms","start":"2026-05-08T23:12:59.810466Z","end":"2026-05-08T23:13:00.178496Z","steps":["trace[450732238] 'process raft request'  (duration: 367.887336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:00.178511Z","caller":"traceutil/trace.go:171","msg":"trace[1516036073] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1910; }","duration":"235.161509ms","start":"2026-05-08T23:12:59.943326Z","end":"2026-05-08T23:13:00.178487Z","steps":["trace[1516036073] 'read index received'  (duration: 56.962µs)","trace[1516036073] 'applied index is now lower than readState.Index'  (duration: 235.103827ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:13:00.178542Z","caller":"traceutil/trace.go:171","msg":"trace[1229253674] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"347.783735ms","start":"2026-05-08T23:12:59.830741Z","end":"2026-05-08T23:13:00.178525Z","steps":["trace[1229253674] 'process raft request'  (duration: 347.710984ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:00.178651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.830723Z","time spent":"347.868457ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1815 > 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-08T23:13:00.178675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.806999Z","time spent":"370.93343ms","remote":"127.0.0.1:50570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1470,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-4t4kp\" mod_revision:1811 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-4t4kp\" value_size:1390 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-4t4kp\" > >"}
{"level":"info","ts":"2026-05-08T23:13:00.178653Z","caller":"traceutil/trace.go:171","msg":"trace[1245542274] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"368.772928ms","start":"2026-05-08T23:12:59.809827Z","end":"2026-05-08T23:13:00.1786Z","steps":["trace[1245542274] 'process raft request'  (duration: 368.050461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:00.178846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.809804Z","time spent":"368.947902ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1814 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:13:00.178559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:12:59.810456Z","time spent":"368.076381ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a6b66ce-e9da-4ea0-a286-3e81806225fe\" mod_revision:1796 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a6b66ce-e9da-4ea0-a286-3e81806225fe\" value_size:3631 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a6b66ce-e9da-4ea0-a286-3e81806225fe\" > >"}
{"level":"warn","ts":"2026-05-08T23:13:00.178862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.846412ms","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-08T23:13:00.178916Z","caller":"traceutil/trace.go:171","msg":"trace[328852895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1848; }","duration":"186.900973ms","start":"2026-05-08T23:12:59.991999Z","end":"2026-05-08T23:13:00.1789Z","steps":["trace[328852895] 'agreement among raft nodes before linearized reading'  (duration: 186.7485ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:00.17886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.528728ms","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-08T23:13:00.178997Z","caller":"traceutil/trace.go:171","msg":"trace[83448847] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1848; }","duration":"235.670211ms","start":"2026-05-08T23:12:59.94331Z","end":"2026-05-08T23:13:00.178981Z","steps":["trace[83448847] 'agreement among raft nodes before linearized reading'  (duration: 235.371774ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:07.438904Z","caller":"traceutil/trace.go:171","msg":"trace[838857601] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"128.417645ms","start":"2026-05-08T23:13:07.31046Z","end":"2026-05-08T23:13:07.438878Z","steps":["trace[838857601] 'process raft request'  (duration: 119.541222ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:50.177466Z","caller":"traceutil/trace.go:171","msg":"trace[2101338840] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"149.602015ms","start":"2026-05-08T23:13:50.027838Z","end":"2026-05-08T23:13:50.17744Z","steps":["trace[2101338840] 'read index received'  (duration: 149.454961ms)","trace[2101338840] 'applied index is now lower than readState.Index'  (duration: 145.984µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:13:50.177587Z","caller":"traceutil/trace.go:171","msg":"trace[925912963] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"168.776725ms","start":"2026-05-08T23:13:50.008778Z","end":"2026-05-08T23:13:50.177554Z","steps":["trace[925912963] 'process raft request'  (duration: 168.511038ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:50.177701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.84048ms","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-08T23:13:50.177751Z","caller":"traceutil/trace.go:171","msg":"trace[1832934093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2166; }","duration":"149.933162ms","start":"2026-05-08T23:13:50.027804Z","end":"2026-05-08T23:13:50.177737Z","steps":["trace[1832934093] 'agreement among raft nodes before linearized reading'  (duration: 149.742237ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:50.487469Z","caller":"traceutil/trace.go:171","msg":"trace[1904867368] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"305.606383ms","start":"2026-05-08T23:13:50.181837Z","end":"2026-05-08T23:13:50.487443Z","steps":["trace[1904867368] 'process raft request'  (duration: 305.46299ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:13:50.487799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:13:50.181808Z","time spent":"305.908701ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2157 > 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-08T23:13:50.602377Z","caller":"traceutil/trace.go:171","msg":"trace[737824748] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"222.721008ms","start":"2026-05-08T23:13:50.379623Z","end":"2026-05-08T23:13:50.602344Z","steps":["trace[737824748] 'process raft request'  (duration: 219.639604ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:13:50.602393Z","caller":"traceutil/trace.go:171","msg":"trace[2137206740] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"208.819224ms","start":"2026-05-08T23:13:50.39355Z","end":"2026-05-08T23:13:50.602369Z","steps":["trace[2137206740] 'process raft request'  (duration: 208.712702ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:14:37.565156Z","caller":"traceutil/trace.go:171","msg":"trace[738403563] transaction","detail":"{read_only:false; response_revision:2596; number_of_response:1; }","duration":"211.325494ms","start":"2026-05-08T23:14:37.353796Z","end":"2026-05-08T23:14:37.565121Z","steps":["trace[738403563] 'process raft request'  (duration: 211.050238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:15:11.78787Z","caller":"traceutil/trace.go:171","msg":"trace[782501863] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"114.476827ms","start":"2026-05-08T23:15:11.673368Z","end":"2026-05-08T23:15:11.787845Z","steps":["trace[782501863] 'process raft request'  (duration: 114.344194ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:15:12.343388Z","caller":"traceutil/trace.go:171","msg":"trace[1006344477] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"202.272805ms","start":"2026-05-08T23:15:12.141087Z","end":"2026-05-08T23:15:12.34336Z","steps":["trace[1006344477] 'process raft request'  (duration: 138.368941ms)","trace[1006344477] 'compare'  (duration: 63.793231ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:02.676227Z","caller":"traceutil/trace.go:171","msg":"trace[569143974] linearizableReadLoop","detail":"{readStateIndex:5143; appliedIndex:5142; }","duration":"137.626296ms","start":"2026-05-08T23:19:02.53857Z","end":"2026-05-08T23:19:02.676196Z","steps":["trace[569143974] 'read index received'  (duration: 137.474213ms)","trace[569143974] 'applied index is now lower than readState.Index'  (duration: 150.803µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:02.676346Z","caller":"traceutil/trace.go:171","msg":"trace[1920834384] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"149.482635ms","start":"2026-05-08T23:19:02.526824Z","end":"2026-05-08T23:19:02.676307Z","steps":["trace[1920834384] 'process raft request'  (duration: 149.104866ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:02.676399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.80358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:19:02.676451Z","caller":"traceutil/trace.go:171","msg":"trace[651893580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4959; }","duration":"137.912493ms","start":"2026-05-08T23:19:02.538524Z","end":"2026-05-08T23:19:02.676436Z","steps":["trace[651893580] 'agreement among raft nodes before linearized reading'  (duration: 137.807781ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:02.703108Z","caller":"traceutil/trace.go:171","msg":"trace[1431935655] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"144.820211ms","start":"2026-05-08T23:19:02.558237Z","end":"2026-05-08T23:19:02.703057Z","steps":["trace[1431935655] 'process raft request'  (duration: 144.38436ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:14.858023Z","caller":"traceutil/trace.go:171","msg":"trace[187581996] linearizableReadLoop","detail":"{readStateIndex:5395; appliedIndex:5394; }","duration":"212.541682ms","start":"2026-05-08T23:19:14.645461Z","end":"2026-05-08T23:19:14.858003Z","steps":["trace[187581996] 'read index received'  (duration: 212.45089ms)","trace[187581996] 'applied index is now lower than readState.Index'  (duration: 90.022µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:19:14.858146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.665365ms","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-08T23:19:14.858186Z","caller":"traceutil/trace.go:171","msg":"trace[1271619991] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5204; }","duration":"212.730696ms","start":"2026-05-08T23:19:14.645431Z","end":"2026-05-08T23:19:14.858162Z","steps":["trace[1271619991] 'agreement among raft nodes before linearized reading'  (duration: 212.654394ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:14.858337Z","caller":"traceutil/trace.go:171","msg":"trace[1830599145] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"216.713235ms","start":"2026-05-08T23:19:14.641585Z","end":"2026-05-08T23:19:14.858298Z","steps":["trace[1830599145] 'process raft request'  (duration: 216.300945ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:15.00355Z","caller":"traceutil/trace.go:171","msg":"trace[450742219] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"272.052543ms","start":"2026-05-08T23:19:14.731456Z","end":"2026-05-08T23:19:15.003509Z","steps":["trace[450742219] 'process raft request'  (duration: 256.214288ms)","trace[450742219] 'compare'  (duration: 15.361764ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:15.003842Z","caller":"traceutil/trace.go:171","msg":"trace[202502103] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"227.521727ms","start":"2026-05-08T23:19:14.776265Z","end":"2026-05-08T23:19:15.003787Z","steps":["trace[202502103] 'process raft request'  (duration: 227.161038ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:15.003982Z","caller":"traceutil/trace.go:171","msg":"trace[1737460580] linearizableReadLoop","detail":"{readStateIndex:5397; appliedIndex:5395; }","duration":"142.164716ms","start":"2026-05-08T23:19:14.861747Z","end":"2026-05-08T23:19:15.003912Z","steps":["trace[1737460580] 'read index received'  (duration: 125.907971ms)","trace[1737460580] 'applied index is now lower than readState.Index'  (duration: 16.250805ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:19:15.004045Z","caller":"traceutil/trace.go:171","msg":"trace[1583546315] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"141.300587ms","start":"2026-05-08T23:19:14.862719Z","end":"2026-05-08T23:19:15.00402Z","steps":["trace[1583546315] 'process raft request'  (duration: 141.029109ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:19:15.004168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.395103ms","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-08T23:19:15.004237Z","caller":"traceutil/trace.go:171","msg":"trace[1698504148] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"140.540008ms","start":"2026-05-08T23:19:14.863658Z","end":"2026-05-08T23:19:15.004198Z","steps":["trace[1698504148] 'process raft request'  (duration: 140.23696ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:15.004285Z","caller":"traceutil/trace.go:171","msg":"trace[381649154] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5207; }","duration":"142.540416ms","start":"2026-05-08T23:19:14.861717Z","end":"2026-05-08T23:19:15.004257Z","steps":["trace[381649154] 'agreement among raft nodes before linearized reading'  (duration: 142.340952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:15.004526Z","caller":"traceutil/trace.go:171","msg":"trace[1595472660] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"140.588719ms","start":"2026-05-08T23:19:14.863925Z","end":"2026-05-08T23:19:15.004513Z","steps":["trace[1595472660] 'process raft request'  (duration: 140.202699ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:19:15.004546Z","caller":"traceutil/trace.go:171","msg":"trace[1335960457] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"140.407974ms","start":"2026-05-08T23:19:14.864129Z","end":"2026-05-08T23:19:15.004537Z","steps":["trace[1335960457] 'process raft request'  (duration: 140.2289ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:20:54.981095Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3039}
{"level":"info","ts":"2026-05-08T23:20:55.066102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3039,"took":"83.547364ms","hash":2185414327,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":32137216,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-08T23:20:55.066171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2185414327,"revision":3039,"compact-revision":-1}
{"level":"info","ts":"2026-05-08T23:25:22.215105Z","caller":"traceutil/trace.go:171","msg":"trace[1459530650] transaction","detail":"{read_only:false; response_revision:8159; number_of_response:1; }","duration":"109.100645ms","start":"2026-05-08T23:25:22.105966Z","end":"2026-05-08T23:25:22.215066Z","steps":["trace[1459530650] 'process raft request'  (duration: 108.932241ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:25:22.374928Z","caller":"traceutil/trace.go:171","msg":"trace[1248453504] linearizableReadLoop","detail":"{readStateIndex:8442; appliedIndex:8441; }","duration":"111.120284ms","start":"2026-05-08T23:25:22.263787Z","end":"2026-05-08T23:25:22.374907Z","steps":["trace[1248453504] 'read index received'  (duration: 110.299575ms)","trace[1248453504] 'applied index is now lower than readState.Index'  (duration: 819.699µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:25:22.375055Z","caller":"traceutil/trace.go:171","msg":"trace[1727345696] transaction","detail":"{read_only:false; response_revision:8160; number_of_response:1; }","duration":"155.721654ms","start":"2026-05-08T23:25:22.219272Z","end":"2026-05-08T23:25:22.374993Z","steps":["trace[1727345696] 'process raft request'  (duration: 154.751391ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:25:22.375111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.289838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:25:22.375179Z","caller":"traceutil/trace.go:171","msg":"trace[152205427] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:8160; }","duration":"111.40207ms","start":"2026-05-08T23:25:22.263758Z","end":"2026-05-08T23:25:22.37516Z","steps":["trace[152205427] 'agreement among raft nodes before linearized reading'  (duration: 111.253367ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:25:33.658493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.968201ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921411246 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8208 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T23:25:33.658667Z","caller":"traceutil/trace.go:171","msg":"trace[2015411651] transaction","detail":"{read_only:false; response_revision:8220; number_of_response:1; }","duration":"325.559875ms","start":"2026-05-08T23:25:33.33308Z","end":"2026-05-08T23:25:33.65864Z","steps":["trace[2015411651] 'process raft request'  (duration: 180.335978ms)","trace[2015411651] 'compare'  (duration: 144.718325ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:25:33.658778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:25:33.333064Z","time spent":"325.652467ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8208 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-08T23:25:33.713662Z","caller":"traceutil/trace.go:171","msg":"trace[1079314664] linearizableReadLoop","detail":"{readStateIndex:8506; appliedIndex:8504; }","duration":"173.115295ms","start":"2026-05-08T23:25:33.540519Z","end":"2026-05-08T23:25:33.713635Z","steps":["trace[1079314664] 'read index received'  (duration: 58.357048ms)","trace[1079314664] 'applied index is now lower than readState.Index'  (duration: 114.756677ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:25:33.713824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.292109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:25:33.713865Z","caller":"traceutil/trace.go:171","msg":"trace[1080767093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8220; }","duration":"173.409682ms","start":"2026-05-08T23:25:33.540444Z","end":"2026-05-08T23:25:33.713854Z","steps":["trace[1080767093] 'agreement among raft nodes before linearized reading'  (duration: 173.29156ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:25:34.603228Z","caller":"traceutil/trace.go:171","msg":"trace[340356763] linearizableReadLoop","detail":"{readStateIndex:8509; appliedIndex:8508; }","duration":"176.151287ms","start":"2026-05-08T23:25:34.427053Z","end":"2026-05-08T23:25:34.603205Z","steps":["trace[340356763] 'read index received'  (duration: 156.478377ms)","trace[340356763] 'applied index is now lower than readState.Index'  (duration: 19.6719ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:25:34.603315Z","caller":"traceutil/trace.go:171","msg":"trace[1662673830] transaction","detail":"{read_only:false; response_revision:8223; number_of_response:1; }","duration":"188.187536ms","start":"2026-05-08T23:25:34.415106Z","end":"2026-05-08T23:25:34.603293Z","steps":["trace[1662673830] 'process raft request'  (duration: 168.450083ms)","trace[1662673830] 'compare'  (duration: 19.464516ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:25:34.603425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.364833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-08T23:25:34.603474Z","caller":"traceutil/trace.go:171","msg":"trace[264354432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8223; }","duration":"176.457095ms","start":"2026-05-08T23:25:34.427007Z","end":"2026-05-08T23:25:34.603464Z","steps":["trace[264354432] 'agreement among raft nodes before linearized reading'  (duration: 176.319711ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:25:34.603619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.63301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-skgd4\" ","response":"range_response_count:1 size:6441"}
{"level":"info","ts":"2026-05-08T23:25:34.603664Z","caller":"traceutil/trace.go:171","msg":"trace[1886102229] range","detail":"{range_begin:/registry/pods/openstack/keepalived-skgd4; range_end:; response_count:1; response_revision:8223; }","duration":"156.717472ms","start":"2026-05-08T23:25:34.446937Z","end":"2026-05-08T23:25:34.603654Z","steps":["trace[1886102229] 'agreement among raft nodes before linearized reading'  (duration: 156.598899ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:25:54.992534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6186}
{"level":"info","ts":"2026-05-08T23:25:55.092777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6186,"took":"98.132859ms","hash":2793772717,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":23199744,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-08T23:25:55.09283Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2793772717,"revision":6186,"compact-revision":3039}
{"level":"info","ts":"2026-05-08T23:26:00.916288Z","caller":"traceutil/trace.go:171","msg":"trace[83384495] linearizableReadLoop","detail":"{readStateIndex:8713; appliedIndex:8711; }","duration":"192.257143ms","start":"2026-05-08T23:26:00.723994Z","end":"2026-05-08T23:26:00.916251Z","steps":["trace[83384495] 'read index received'  (duration: 11.510695ms)","trace[83384495] 'applied index is now lower than readState.Index'  (duration: 180.744708ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:26:00.916306Z","caller":"traceutil/trace.go:171","msg":"trace[1720871109] transaction","detail":"{read_only:false; response_revision:8419; number_of_response:1; }","duration":"194.899447ms","start":"2026-05-08T23:26:00.721377Z","end":"2026-05-08T23:26:00.916276Z","steps":["trace[1720871109] 'process raft request'  (duration: 179.609361ms)","trace[1720871109] 'compare'  (duration: 15.06741ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:26:00.916527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.863269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-skgd4\" ","response":"range_response_count:1 size:6441"}
{"level":"warn","ts":"2026-05-08T23:26:00.916565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.5616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-08T23:26:00.916609Z","caller":"traceutil/trace.go:171","msg":"trace[685440658] range","detail":"{range_begin:/registry/pods/openstack/keepalived-skgd4; range_end:; response_count:1; response_revision:8419; }","duration":"139.989142ms","start":"2026-05-08T23:26:00.776601Z","end":"2026-05-08T23:26:00.91659Z","steps":["trace[685440658] 'agreement among raft nodes before linearized reading'  (duration: 139.849889ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:00.916632Z","caller":"traceutil/trace.go:171","msg":"trace[588710526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8419; }","duration":"192.662683ms","start":"2026-05-08T23:26:00.723951Z","end":"2026-05-08T23:26:00.916613Z","steps":["trace[588710526] 'agreement among raft nodes before linearized reading'  (duration: 192.434527ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:02.16717Z","caller":"traceutil/trace.go:171","msg":"trace[750180036] transaction","detail":"{read_only:false; response_revision:8425; number_of_response:1; }","duration":"131.481207ms","start":"2026-05-08T23:26:02.035668Z","end":"2026-05-08T23:26:02.167149Z","steps":["trace[750180036] 'process raft request'  (duration: 131.079177ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:15.308918Z","caller":"traceutil/trace.go:171","msg":"trace[1496834374] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"230.111939ms","start":"2026-05-08T23:26:15.078775Z","end":"2026-05-08T23:26:15.308887Z","steps":["trace[1496834374] 'process raft request'  (duration: 229.873203ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:26:16.300492Z","caller":"traceutil/trace.go:171","msg":"trace[373355724] transaction","detail":"{read_only:false; response_revision:8547; number_of_response:1; }","duration":"243.196513ms","start":"2026-05-08T23:26:16.05726Z","end":"2026-05-08T23:26:16.300457Z","steps":["trace[373355724] 'process raft request'  (duration: 210.06791ms)","trace[373355724] 'compare'  (duration: 32.195ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:26:58.870626Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000241a.wal"}
{"level":"info","ts":"2026-05-08T23:27:32.868348Z","caller":"traceutil/trace.go:171","msg":"trace[1931990422] linearizableReadLoop","detail":"{readStateIndex:9616; appliedIndex:9615; }","duration":"172.032069ms","start":"2026-05-08T23:27:32.696288Z","end":"2026-05-08T23:27:32.86832Z","steps":["trace[1931990422] 'read index received'  (duration: 171.834315ms)","trace[1931990422] 'applied index is now lower than readState.Index'  (duration: 196.574µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:27:32.868455Z","caller":"traceutil/trace.go:171","msg":"trace[630492880] transaction","detail":"{read_only:false; response_revision:9296; number_of_response:1; }","duration":"235.280023ms","start":"2026-05-08T23:27:32.633141Z","end":"2026-05-08T23:27:32.868421Z","steps":["trace[630492880] 'process raft request'  (duration: 235.030777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:27:32.868616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.310916ms","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-08T23:27:32.868661Z","caller":"traceutil/trace.go:171","msg":"trace[580425898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9296; }","duration":"172.404998ms","start":"2026-05-08T23:27:32.696246Z","end":"2026-05-08T23:27:32.868651Z","steps":["trace[580425898] 'agreement among raft nodes before linearized reading'  (duration: 172.222794ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:27:32.868695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.534478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:27:32.868815Z","caller":"traceutil/trace.go:171","msg":"trace[1606838091] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:9296; }","duration":"156.716282ms","start":"2026-05-08T23:27:32.712072Z","end":"2026-05-08T23:27:32.868788Z","steps":["trace[1606838091] 'agreement among raft nodes before linearized reading'  (duration: 156.504537ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:28:23.744073Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T23:28:23.750374Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-08T23:28:23.750507Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-08T23:30:55.250868Z","caller":"traceutil/trace.go:171","msg":"trace[1873257268] transaction","detail":"{read_only:false; response_revision:11025; number_of_response:1; }","duration":"256.469153ms","start":"2026-05-08T23:30:54.994364Z","end":"2026-05-08T23:30:55.250833Z","steps":["trace[1873257268] 'process raft request'  (duration: 256.284449ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:30:55.254421Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8341}
{"level":"info","ts":"2026-05-08T23:30:55.330401Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8341,"took":"73.323707ms","hash":3985073850,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":26714112,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-08T23:30:55.330499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3985073850,"revision":8341,"compact-revision":6186}
{"level":"warn","ts":"2026-05-08T23:31:17.13885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.20675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-08T23:31:17.138965Z","caller":"traceutil/trace.go:171","msg":"trace[1252457187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11147; }","duration":"139.373533ms","start":"2026-05-08T23:31:16.999571Z","end":"2026-05-08T23:31:17.138945Z","steps":["trace[1252457187] 'range keys from in-memory index tree'  (duration: 138.981685ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:31:17.139201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.767229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-skgd4\" ","response":"range_response_count:1 size:6441"}
{"level":"info","ts":"2026-05-08T23:31:17.139351Z","caller":"traceutil/trace.go:171","msg":"trace[2010135131] range","detail":"{range_begin:/registry/pods/openstack/keepalived-skgd4; range_end:; response_count:1; response_revision:11147; }","duration":"111.131697ms","start":"2026-05-08T23:31:17.028146Z","end":"2026-05-08T23:31:17.139278Z","steps":["trace[2010135131] 'range keys from in-memory index tree'  (duration: 110.433531ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:35:55.259877Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11025}
{"level":"info","ts":"2026-05-08T23:35:55.341962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11025,"took":"79.809585ms","hash":795834136,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":28393472,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-08T23:35:55.342032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":795834136,"revision":11025,"compact-revision":8341}
{"level":"info","ts":"2026-05-08T23:37:43.920981Z","caller":"traceutil/trace.go:171","msg":"trace[1021783019] transaction","detail":"{read_only:false; response_revision:13750; number_of_response:1; }","duration":"383.480621ms","start":"2026-05-08T23:37:43.537471Z","end":"2026-05-08T23:37:43.920952Z","steps":["trace[1021783019] 'process raft request'  (duration: 383.299827ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:37:43.921141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:37:43.537445Z","time spent":"383.620284ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11811,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/openvswitch-qrv2x\" mod_revision:13741 > success:<request_put:<key:\"/registry/pods/openstack/openvswitch-qrv2x\" value_size:11761 >> failure:<request_range:<key:\"/registry/pods/openstack/openvswitch-qrv2x\" > >"}
{"level":"info","ts":"2026-05-08T23:37:43.933777Z","caller":"traceutil/trace.go:171","msg":"trace[494091846] linearizableReadLoop","detail":"{readStateIndex:14221; appliedIndex:14218; }","duration":"161.252347ms","start":"2026-05-08T23:37:43.772507Z","end":"2026-05-08T23:37:43.933759Z","steps":["trace[494091846] 'read index received'  (duration: 148.303509ms)","trace[494091846] 'applied index is now lower than readState.Index'  (duration: 12.948198ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:37:43.933899Z","caller":"traceutil/trace.go:171","msg":"trace[304529681] transaction","detail":"{read_only:false; response_revision:13752; number_of_response:1; }","duration":"165.619072ms","start":"2026-05-08T23:37:43.768269Z","end":"2026-05-08T23:37:43.933888Z","steps":["trace[304529681] 'process raft request'  (duration: 165.461268ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:37:43.933925Z","caller":"traceutil/trace.go:171","msg":"trace[1880923243] transaction","detail":"{read_only:false; response_revision:13751; number_of_response:1; }","duration":"170.612711ms","start":"2026-05-08T23:37:43.763273Z","end":"2026-05-08T23:37:43.933885Z","steps":["trace[1880923243] 'process raft request'  (duration: 170.352535ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:37:43.934036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.518273ms","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-08T23:37:43.934055Z","caller":"traceutil/trace.go:171","msg":"trace[317705190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13752; }","duration":"161.577385ms","start":"2026-05-08T23:37:43.772472Z","end":"2026-05-08T23:37:43.934049Z","steps":["trace[317705190] 'agreement among raft nodes before linearized reading'  (duration: 161.354679ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:37:53.330849Z","caller":"traceutil/trace.go:171","msg":"trace[2064310058] transaction","detail":"{read_only:false; response_revision:13916; number_of_response:1; }","duration":"252.853513ms","start":"2026-05-08T23:37:53.07797Z","end":"2026-05-08T23:37:53.330824Z","steps":["trace[2064310058] 'process raft request'  (duration: 252.70957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:37:53.368533Z","caller":"traceutil/trace.go:171","msg":"trace[1282092547] linearizableReadLoop","detail":"{readStateIndex:14388; appliedIndex:14386; }","duration":"138.474483ms","start":"2026-05-08T23:37:53.230038Z","end":"2026-05-08T23:37:53.368513Z","steps":["trace[1282092547] 'read index received'  (duration: 100.59598ms)","trace[1282092547] 'applied index is now lower than readState.Index'  (duration: 37.877423ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:37:53.368548Z","caller":"traceutil/trace.go:171","msg":"trace[299622004] transaction","detail":"{read_only:false; response_revision:13917; number_of_response:1; }","duration":"215.381939ms","start":"2026-05-08T23:37:53.153135Z","end":"2026-05-08T23:37:53.368517Z","steps":["trace[299622004] 'process raft request'  (duration: 213.607438ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:37:53.369066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.979666ms","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-08T23:37:53.369261Z","caller":"traceutil/trace.go:171","msg":"trace[654309782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13918; }","duration":"139.206881ms","start":"2026-05-08T23:37:53.230001Z","end":"2026-05-08T23:37:53.369208Z","steps":["trace[654309782] 'agreement among raft nodes before linearized reading'  (duration: 138.635457ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:39:20.452737Z","caller":"traceutil/trace.go:171","msg":"trace[17548107] linearizableReadLoop","detail":"{readStateIndex:15437; appliedIndex:15436; }","duration":"239.441574ms","start":"2026-05-08T23:39:20.213271Z","end":"2026-05-08T23:39:20.452713Z","steps":["trace[17548107] 'read index received'  (duration: 239.27987ms)","trace[17548107] 'applied index is now lower than readState.Index'  (duration: 160.714µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:39:20.452797Z","caller":"traceutil/trace.go:171","msg":"trace[1969567077] transaction","detail":"{read_only:false; response_revision:14934; number_of_response:1; }","duration":"261.005059ms","start":"2026-05-08T23:39:20.19177Z","end":"2026-05-08T23:39:20.452775Z","steps":["trace[1969567077] 'process raft request'  (duration: 260.803334ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.452942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.65302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-05-08T23:39:20.45298Z","caller":"traceutil/trace.go:171","msg":"trace[1825846372] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14934; }","duration":"239.732972ms","start":"2026-05-08T23:39:20.213237Z","end":"2026-05-08T23:39:20.45297Z","steps":["trace[1825846372] 'agreement among raft nodes before linearized reading'  (duration: 239.595058ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:39:20.614581Z","caller":"traceutil/trace.go:171","msg":"trace[652354375] linearizableReadLoop","detail":"{readStateIndex:15439; appliedIndex:15437; }","duration":"161.745741ms","start":"2026-05-08T23:39:20.452813Z","end":"2026-05-08T23:39:20.614559Z","steps":["trace[652354375] 'read index received'  (duration: 148.267369ms)","trace[652354375] 'applied index is now lower than readState.Index'  (duration: 13.477352ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:39:20.614795Z","caller":"traceutil/trace.go:171","msg":"trace[983079800] transaction","detail":"{read_only:false; response_revision:14935; number_of_response:1; }","duration":"301.522076ms","start":"2026-05-08T23:39:20.313238Z","end":"2026-05-08T23:39:20.61476Z","steps":["trace[983079800] 'process raft request'  (duration: 287.89516ms)","trace[983079800] 'compare'  (duration: 12.881438ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:39:20.614915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.045378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-29v8z\" ","response":"range_response_count:1 size:22009"}
{"level":"info","ts":"2026-05-08T23:39:20.614954Z","caller":"traceutil/trace.go:171","msg":"trace[1726255450] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-29v8z; range_end:; response_count:1; response_revision:14936; }","duration":"341.11492ms","start":"2026-05-08T23:39:20.273829Z","end":"2026-05-08T23:39:20.614943Z","steps":["trace[1726255450] 'agreement among raft nodes before linearized reading'  (duration: 341.030508ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.614967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:39:20.313218Z","time spent":"301.666019ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:14924 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:39:20.615028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.075592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:39:20.615061Z","caller":"traceutil/trace.go:171","msg":"trace[800676489] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14936; }","duration":"401.122284ms","start":"2026-05-08T23:39:20.213931Z","end":"2026-05-08T23:39:20.615053Z","steps":["trace[800676489] 'agreement among raft nodes before linearized reading'  (duration: 401.077723ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.615085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:39:20.213923Z","time spent":"401.156844ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "}
{"level":"warn","ts":"2026-05-08T23:39:20.614832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.298688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-29v8z\" ","response":"range_response_count:1 size:22009"}
{"level":"info","ts":"2026-05-08T23:39:20.615224Z","caller":"traceutil/trace.go:171","msg":"trace[678632516] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-29v8z; range_end:; response_count:1; response_revision:14936; }","duration":"339.728597ms","start":"2026-05-08T23:39:20.275479Z","end":"2026-05-08T23:39:20.615208Z","steps":["trace[678632516] 'agreement among raft nodes before linearized reading'  (duration: 339.209685ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.615278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:39:20.275469Z","time spent":"339.79285ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22033,"request content":"key:\"/registry/pods/openstack/nova-compute-default-29v8z\" "}
{"level":"warn","ts":"2026-05-08T23:39:20.615325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.983793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:39:20.615352Z","caller":"traceutil/trace.go:171","msg":"trace[708824997] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14936; }","duration":"402.041806ms","start":"2026-05-08T23:39:20.213302Z","end":"2026-05-08T23:39:20.615344Z","steps":["trace[708824997] 'agreement among raft nodes before linearized reading'  (duration: 402.005264ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.615377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:39:20.213284Z","time spent":"402.087737ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "}
{"level":"info","ts":"2026-05-08T23:39:20.61518Z","caller":"traceutil/trace.go:171","msg":"trace[2009282836] transaction","detail":"{read_only:false; response_revision:14936; number_of_response:1; }","duration":"295.307137ms","start":"2026-05-08T23:39:20.319849Z","end":"2026-05-08T23:39:20.615156Z","steps":["trace[2009282836] 'process raft request'  (duration: 294.57816ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.614988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:39:20.273812Z","time spent":"341.169261ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22033,"request content":"key:\"/registry/pods/openstack/nova-compute-default-29v8z\" "}
{"level":"warn","ts":"2026-05-08T23:39:20.61552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.771088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:39:20.615546Z","caller":"traceutil/trace.go:171","msg":"trace[1829620751] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14936; }","duration":"116.830288ms","start":"2026-05-08T23:39:20.498708Z","end":"2026-05-08T23:39:20.615538Z","steps":["trace[1829620751] 'agreement among raft nodes before linearized reading'  (duration: 116.790607ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.61529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.559223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:39:20.615706Z","caller":"traceutil/trace.go:171","msg":"trace[972510579] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14936; }","duration":"401.980865ms","start":"2026-05-08T23:39:20.213707Z","end":"2026-05-08T23:39:20.615688Z","steps":["trace[972510579] 'agreement among raft nodes before linearized reading'  (duration: 401.560904ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.615767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:39:20.213691Z","time spent":"402.059366ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-05-08T23:39:20.614936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.737483ms","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-08T23:39:20.616201Z","caller":"traceutil/trace.go:171","msg":"trace[1668115721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14936; }","duration":"244.118686ms","start":"2026-05-08T23:39:20.372065Z","end":"2026-05-08T23:39:20.616184Z","steps":["trace[1668115721] 'agreement among raft nodes before linearized reading'  (duration: 242.507707ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.616649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.74362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-08T23:39:20.616734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.995553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-05-08T23:39:20.616826Z","caller":"traceutil/trace.go:171","msg":"trace[1469793468] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14936; }","duration":"117.107775ms","start":"2026-05-08T23:39:20.499695Z","end":"2026-05-08T23:39:20.616802Z","steps":["trace[1469793468] 'agreement among raft nodes before linearized reading'  (duration: 116.873649ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:39:20.616972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.182351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T23:39:20.617006Z","caller":"traceutil/trace.go:171","msg":"trace[520730843] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14936; }","duration":"118.238351ms","start":"2026-05-08T23:39:20.498758Z","end":"2026-05-08T23:39:20.616996Z","steps":["trace[520730843] 'agreement among raft nodes before linearized reading'  (duration: 118.18971ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:39:20.616731Z","caller":"traceutil/trace.go:171","msg":"trace[219313562] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14936; }","duration":"117.864993ms","start":"2026-05-08T23:39:20.49885Z","end":"2026-05-08T23:39:20.616715Z","steps":["trace[219313562] 'agreement among raft nodes before linearized reading'  (duration: 117.75118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:40:55.273518Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13066}
{"level":"info","ts":"2026-05-08T23:40:55.351544Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13066,"took":"74.482317ms","hash":1782575863,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":31440896,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-08T23:40:55.351603Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1782575863,"revision":13066,"compact-revision":11025}
{"level":"info","ts":"2026-05-08T23:45:16.528476Z","caller":"traceutil/trace.go:171","msg":"trace[283735872] transaction","detail":"{read_only:false; response_revision:17638; number_of_response:1; }","duration":"162.821237ms","start":"2026-05-08T23:45:16.365622Z","end":"2026-05-08T23:45:16.528444Z","steps":["trace[283735872] 'process raft request'  (duration: 120.225311ms)","trace[283735872] 'compare'  (duration: 42.460413ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:45:16.915148Z","caller":"traceutil/trace.go:171","msg":"trace[417428495] transaction","detail":"{read_only:false; response_revision:17639; number_of_response:1; }","duration":"118.684633ms","start":"2026-05-08T23:45:16.796429Z","end":"2026-05-08T23:45:16.915114Z","steps":["trace[417428495] 'process raft request'  (duration: 118.237192ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:45:17.384194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.894761ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921440384 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17628 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:45:17.384446Z","caller":"traceutil/trace.go:171","msg":"trace[1554982370] transaction","detail":"{read_only:false; response_revision:17641; number_of_response:1; }","duration":"244.853556ms","start":"2026-05-08T23:45:17.139571Z","end":"2026-05-08T23:45:17.384425Z","steps":["trace[1554982370] 'process raft request'  (duration: 244.739243ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:45:17.384587Z","caller":"traceutil/trace.go:171","msg":"trace[181819907] transaction","detail":"{read_only:false; response_revision:17640; number_of_response:1; }","duration":"517.437593ms","start":"2026-05-08T23:45:16.867118Z","end":"2026-05-08T23:45:17.384555Z","steps":["trace[181819907] 'process raft request'  (duration: 85.07187ms)","trace[181819907] 'compare'  (duration: 431.656856ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:45:17.384655Z","caller":"traceutil/trace.go:171","msg":"trace[771634300] linearizableReadLoop","detail":"{readStateIndex:18229; appliedIndex:18228; }","duration":"464.457529ms","start":"2026-05-08T23:45:16.920162Z","end":"2026-05-08T23:45:17.38462Z","steps":["trace[771634300] 'read index received'  (duration: 31.900001ms)","trace[771634300] 'applied index is now lower than readState.Index'  (duration: 432.553798ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:45:17.384874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:45:16.86708Z","time spent":"517.640198ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17628 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-08T23:45:17.385137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.461902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-lrdhc\" ","response":"range_response_count:1 size:20767"}
{"level":"info","ts":"2026-05-08T23:45:17.385231Z","caller":"traceutil/trace.go:171","msg":"trace[791115862] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-lrdhc; range_end:; response_count:1; response_revision:17641; }","duration":"395.603884ms","start":"2026-05-08T23:45:16.989604Z","end":"2026-05-08T23:45:17.385208Z","steps":["trace[791115862] 'agreement among raft nodes before linearized reading'  (duration: 395.306817ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:45:17.385287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:45:16.989584Z","time spent":"395.693968ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20791,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-lrdhc\" "}
{"level":"warn","ts":"2026-05-08T23:45:17.385815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.651117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:946172"}
{"level":"info","ts":"2026-05-08T23:45:17.385858Z","caller":"traceutil/trace.go:171","msg":"trace[1553226775] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:17641; }","duration":"465.698548ms","start":"2026-05-08T23:45:16.920148Z","end":"2026-05-08T23:45:17.385847Z","steps":["trace[1553226775] 'agreement among raft nodes before linearized reading'  (duration: 464.552621ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:45:17.385885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:45:16.92013Z","time spent":"465.747459ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":96,"response size":946196,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-05-08T23:45:55.280476Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15554}
{"level":"info","ts":"2026-05-08T23:45:55.376908Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15554,"took":"93.147815ms","hash":2671005092,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":33734656,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-08T23:45:55.376977Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2671005092,"revision":15554,"compact-revision":13066}
{"level":"info","ts":"2026-05-08T23:48:54.592316Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-08T23:48:54.596631Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-08T23:48:54.596738Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-08T23:50:46.294048Z","caller":"traceutil/trace.go:171","msg":"trace[1008007902] transaction","detail":"{read_only:false; response_revision:20138; number_of_response:1; }","duration":"112.20495ms","start":"2026-05-08T23:50:46.181812Z","end":"2026-05-08T23:50:46.294017Z","steps":["trace[1008007902] 'process raft request'  (duration: 111.994945ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:50:46.573801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.926334ms","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-08T23:50:46.57389Z","caller":"traceutil/trace.go:171","msg":"trace[1502855409] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20138; }","duration":"159.064198ms","start":"2026-05-08T23:50:46.414805Z","end":"2026-05-08T23:50:46.573869Z","steps":["trace[1502855409] 'range keys from in-memory index tree'  (duration: 158.712879ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:50:46.771657Z","caller":"traceutil/trace.go:171","msg":"trace[1103740043] transaction","detail":"{read_only:false; response_revision:20139; number_of_response:1; }","duration":"206.219445ms","start":"2026-05-08T23:50:46.565416Z","end":"2026-05-08T23:50:46.771635Z","steps":["trace[1103740043] 'process raft request'  (duration: 206.109192ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:50:46.812366Z","caller":"traceutil/trace.go:171","msg":"trace[1390835014] linearizableReadLoop","detail":"{readStateIndex:20813; appliedIndex:20811; }","duration":"237.903011ms","start":"2026-05-08T23:50:46.574438Z","end":"2026-05-08T23:50:46.812341Z","steps":["trace[1390835014] 'read index received'  (duration: 197.156468ms)","trace[1390835014] 'applied index is now lower than readState.Index'  (duration: 40.745503ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:50:46.812413Z","caller":"traceutil/trace.go:171","msg":"trace[1368165817] transaction","detail":"{read_only:false; response_revision:20140; number_of_response:1; }","duration":"243.047113ms","start":"2026-05-08T23:50:46.569323Z","end":"2026-05-08T23:50:46.81237Z","steps":["trace[1368165817] 'process raft request'  (duration: 242.592933ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:50:46.812406Z","caller":"traceutil/trace.go:171","msg":"trace[729116808] transaction","detail":"{read_only:false; response_revision:20141; number_of_response:1; }","duration":"234.185602ms","start":"2026-05-08T23:50:46.578183Z","end":"2026-05-08T23:50:46.812368Z","steps":["trace[729116808] 'process raft request'  (duration: 234.10316ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:50:46.812527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.040145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:50:46.812578Z","caller":"traceutil/trace.go:171","msg":"trace[26437584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20141; }","duration":"238.149847ms","start":"2026-05-08T23:50:46.574409Z","end":"2026-05-08T23:50:46.812559Z","steps":["trace[26437584] 'agreement among raft nodes before linearized reading'  (duration: 238.029494ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:50:55.288058Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18135}
{"level":"info","ts":"2026-05-08T23:50:55.418798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18135,"took":"126.659785ms","hash":1309366945,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":29896704,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T23:50:55.418865Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1309366945,"revision":18135,"compact-revision":15554}
{"level":"warn","ts":"2026-05-08T23:54:29.98679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.471381ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921454391 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22433 > 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-08T23:54:29.987075Z","caller":"traceutil/trace.go:171","msg":"trace[2050287233] transaction","detail":"{read_only:false; response_revision:22475; number_of_response:1; }","duration":"425.726431ms","start":"2026-05-08T23:54:29.561318Z","end":"2026-05-08T23:54:29.987044Z","steps":["trace[2050287233] 'process raft request'  (duration: 425.569667ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:54:29.987153Z","caller":"traceutil/trace.go:171","msg":"trace[1081600440] transaction","detail":"{read_only:false; response_revision:22476; number_of_response:1; }","duration":"408.303435ms","start":"2026-05-08T23:54:29.578835Z","end":"2026-05-08T23:54:29.987138Z","steps":["trace[1081600440] 'process raft request'  (duration: 408.129791ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:54:29.987202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:54:29.578809Z","time spent":"408.368966ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:22435 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T23:54:29.987265Z","caller":"traceutil/trace.go:171","msg":"trace[1269427179] transaction","detail":"{read_only:false; response_revision:22477; number_of_response:1; }","duration":"298.265119ms","start":"2026-05-08T23:54:29.688994Z","end":"2026-05-08T23:54:29.987259Z","steps":["trace[1269427179] 'process raft request'  (duration: 298.003283ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:54:29.987252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:54:29.561299Z","time spent":"425.863794ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22434 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T23:54:29.987326Z","caller":"traceutil/trace.go:171","msg":"trace[1944237446] linearizableReadLoop","detail":"{readStateIndex:23221; appliedIndex:23217; }","duration":"206.927939ms","start":"2026-05-08T23:54:29.780377Z","end":"2026-05-08T23:54:29.987305Z","steps":["trace[1944237446] 'read index received'  (duration: 37.862943ms)","trace[1944237446] 'applied index is now lower than readState.Index'  (duration: 169.063446ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:54:29.987379Z","caller":"traceutil/trace.go:171","msg":"trace[2037140960] transaction","detail":"{read_only:false; response_revision:22474; number_of_response:1; }","duration":"434.108671ms","start":"2026-05-08T23:54:29.553261Z","end":"2026-05-08T23:54:29.987369Z","steps":["trace[2037140960] 'process raft request'  (duration: 264.973673ms)","trace[2037140960] 'compare'  (duration: 168.039661ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:54:29.987422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:54:29.553242Z","time spent":"434.159481ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22433 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:54:29.988131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.752698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-05-08T23:54:29.98818Z","caller":"traceutil/trace.go:171","msg":"trace[766743408] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22479; }","duration":"207.83574ms","start":"2026-05-08T23:54:29.780332Z","end":"2026-05-08T23:54:29.988168Z","steps":["trace[766743408] 'agreement among raft nodes before linearized reading'  (duration: 207.067742ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:55:55.295726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20190}
{"level":"info","ts":"2026-05-08T23:55:55.399353Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20190,"took":"98.974012ms","hash":1134104317,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":42287104,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-08T23:55:55.399491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1134104317,"revision":20190,"compact-revision":18135}
{"level":"info","ts":"2026-05-08T23:57:43.826333Z","caller":"traceutil/trace.go:171","msg":"trace[1725675577] transaction","detail":"{read_only:false; response_revision:24493; number_of_response:1; }","duration":"125.199419ms","start":"2026-05-08T23:57:43.701101Z","end":"2026-05-08T23:57:43.8263Z","steps":["trace[1725675577] 'process raft request'  (duration: 125.021074ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:49.350921Z","caller":"traceutil/trace.go:171","msg":"trace[931245969] transaction","detail":"{read_only:false; response_revision:24533; number_of_response:1; }","duration":"106.362838ms","start":"2026-05-08T23:57:49.244533Z","end":"2026-05-08T23:57:49.350896Z","steps":["trace[931245969] 'process raft request'  (duration: 105.734404ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:49.815904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.473459ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459204 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:24520 > 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-08T23:57:49.815991Z","caller":"traceutil/trace.go:171","msg":"trace[814984547] linearizableReadLoop","detail":"{readStateIndex:25329; appliedIndex:25328; }","duration":"278.290401ms","start":"2026-05-08T23:57:49.537687Z","end":"2026-05-08T23:57:49.815978Z","steps":["trace[814984547] 'read index received'  (duration: 156.68834ms)","trace[814984547] 'applied index is now lower than readState.Index'  (duration: 121.600921ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:49.81611Z","caller":"traceutil/trace.go:171","msg":"trace[1971094693] transaction","detail":"{read_only:false; response_revision:24534; number_of_response:1; }","duration":"292.643954ms","start":"2026-05-08T23:57:49.523454Z","end":"2026-05-08T23:57:49.816098Z","steps":["trace[1971094693] 'process raft request'  (duration: 170.907119ms)","trace[1971094693] 'compare'  (duration: 121.381147ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:49.816232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.522677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:49.816321Z","caller":"traceutil/trace.go:171","msg":"trace[80951876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24534; }","duration":"278.65771ms","start":"2026-05-08T23:57:49.537645Z","end":"2026-05-08T23:57:49.816302Z","steps":["trace[80951876] 'agreement among raft nodes before linearized reading'  (duration: 278.493636ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:50.226054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.669506ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459205 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24481 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:50.226228Z","caller":"traceutil/trace.go:171","msg":"trace[2068104578] transaction","detail":"{read_only:false; response_revision:24536; number_of_response:1; }","duration":"378.482353ms","start":"2026-05-08T23:57:49.847735Z","end":"2026-05-08T23:57:50.226217Z","steps":["trace[2068104578] 'process raft request'  (duration: 378.423192ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:50.226232Z","caller":"traceutil/trace.go:171","msg":"trace[139443802] transaction","detail":"{read_only:false; response_revision:24535; number_of_response:1; }","duration":"568.254682ms","start":"2026-05-08T23:57:49.657955Z","end":"2026-05-08T23:57:50.22621Z","steps":["trace[139443802] 'process raft request'  (duration: 409.35235ms)","trace[139443802] 'compare'  (duration: 158.512343ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:50.226281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:49.847712Z","time spent":"378.545895ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24521 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-08T23:57:50.226315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:49.657927Z","time spent":"568.345083ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24481 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-08T23:57:50.22638Z","caller":"traceutil/trace.go:171","msg":"trace[178563231] linearizableReadLoop","detail":"{readStateIndex:25330; appliedIndex:25329; }","duration":"410.363414ms","start":"2026-05-08T23:57:49.816009Z","end":"2026-05-08T23:57:50.226372Z","steps":["trace[178563231] 'read index received'  (duration: 251.257477ms)","trace[178563231] 'applied index is now lower than readState.Index'  (duration: 159.104957ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:50.226652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.919668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:50.226686Z","caller":"traceutil/trace.go:171","msg":"trace[1689045117] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24536; }","duration":"428.98921ms","start":"2026-05-08T23:57:49.797688Z","end":"2026-05-08T23:57:50.226677Z","steps":["trace[1689045117] 'agreement among raft nodes before linearized reading'  (duration: 428.936909ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:50.226707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:49.797668Z","time spent":"429.033231ms","remote":"127.0.0.1:50268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:57:50.226767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.561746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:50.226814Z","caller":"traceutil/trace.go:171","msg":"trace[676217204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24536; }","duration":"409.640398ms","start":"2026-05-08T23:57:49.817162Z","end":"2026-05-08T23:57:50.226803Z","steps":["trace[676217204] 'agreement among raft nodes before linearized reading'  (duration: 409.573736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:50.226835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.720033ms","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-08T23:57:50.226849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:49.817147Z","time spent":"409.695279ms","remote":"127.0.0.1:50284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-08T23:57:50.226857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.466027ms","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:8"}
{"level":"info","ts":"2026-05-08T23:57:50.226885Z","caller":"traceutil/trace.go:171","msg":"trace[1951224127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24536; }","duration":"216.801565ms","start":"2026-05-08T23:57:50.010072Z","end":"2026-05-08T23:57:50.226873Z","steps":["trace[1951224127] 'agreement among raft nodes before linearized reading'  (duration: 216.680472ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:50.22691Z","caller":"traceutil/trace.go:171","msg":"trace[1170899676] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:24536; }","duration":"335.550369ms","start":"2026-05-08T23:57:49.891341Z","end":"2026-05-08T23:57:50.226892Z","steps":["trace[1170899676] 'agreement among raft nodes before linearized reading'  (duration: 335.466947ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:50.226954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:49.891323Z","time spent":"335.62118ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:57:50.691785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.914497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:50.691851Z","caller":"traceutil/trace.go:171","msg":"trace[1720276390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24538; }","duration":"147.03338ms","start":"2026-05-08T23:57:50.544803Z","end":"2026-05-08T23:57:50.691837Z","steps":["trace[1720276390] 'range keys from in-memory index tree'  (duration: 146.832135ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.032312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.439323ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459220 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24530 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:51.032389Z","caller":"traceutil/trace.go:171","msg":"trace[1015446293] linearizableReadLoop","detail":"{readStateIndex:25339; appliedIndex:25338; }","duration":"161.886654ms","start":"2026-05-08T23:57:50.87049Z","end":"2026-05-08T23:57:51.032377Z","steps":["trace[1015446293] 'read index received'  (duration: 31.337639ms)","trace[1015446293] 'applied index is now lower than readState.Index'  (duration: 130.547965ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:51.032543Z","caller":"traceutil/trace.go:171","msg":"trace[1005364862] transaction","detail":"{read_only:false; response_revision:24544; number_of_response:1; }","duration":"193.326364ms","start":"2026-05-08T23:57:50.839207Z","end":"2026-05-08T23:57:51.032533Z","steps":["trace[1005364862] 'process raft request'  (duration: 62.601095ms)","trace[1005364862] 'compare'  (duration: 130.155316ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:51.032814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.314434ms","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-08T23:57:51.032863Z","caller":"traceutil/trace.go:171","msg":"trace[80596769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24544; }","duration":"162.451497ms","start":"2026-05-08T23:57:50.870399Z","end":"2026-05-08T23:57:51.032851Z","steps":["trace[80596769] 'agreement among raft nodes before linearized reading'  (duration: 162.263212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.033068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.990348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:51.033099Z","caller":"traceutil/trace.go:171","msg":"trace[36475723] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:24544; }","duration":"116.055359ms","start":"2026-05-08T23:57:50.917032Z","end":"2026-05-08T23:57:51.033087Z","steps":["trace[36475723] 'agreement among raft nodes before linearized reading'  (duration: 116.002378ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.319787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.47721ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:51.319905Z","caller":"traceutil/trace.go:171","msg":"trace[1186541809] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24545; }","duration":"147.610263ms","start":"2026-05-08T23:57:51.172275Z","end":"2026-05-08T23:57:51.319885Z","steps":["trace[1186541809] 'range keys from in-memory index tree'  (duration: 147.46328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:51.491523Z","caller":"traceutil/trace.go:171","msg":"trace[1463069295] linearizableReadLoop","detail":"{readStateIndex:25341; appliedIndex:25341; }","duration":"151.416274ms","start":"2026-05-08T23:57:51.340085Z","end":"2026-05-08T23:57:51.491501Z","steps":["trace[1463069295] 'read index received'  (duration: 151.410143ms)","trace[1463069295] 'applied index is now lower than readState.Index'  (duration: 5.011µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:51.492473Z","caller":"traceutil/trace.go:171","msg":"trace[2036580757] transaction","detail":"{read_only:false; response_revision:24546; number_of_response:1; }","duration":"159.22506ms","start":"2026-05-08T23:57:51.333227Z","end":"2026-05-08T23:57:51.492452Z","steps":["trace[2036580757] 'process raft request'  (duration: 158.066593ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.491913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.811983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-08T23:57:51.493303Z","caller":"traceutil/trace.go:171","msg":"trace[1193470750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24546; }","duration":"153.169336ms","start":"2026-05-08T23:57:51.340077Z","end":"2026-05-08T23:57:51.493246Z","steps":["trace[1193470750] 'agreement among raft nodes before linearized reading'  (duration: 151.68334ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.768639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.263703ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24509 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:51.768777Z","caller":"traceutil/trace.go:171","msg":"trace[777934715] linearizableReadLoop","detail":"{readStateIndex:25342; appliedIndex:25341; }","duration":"276.440318ms","start":"2026-05-08T23:57:51.492325Z","end":"2026-05-08T23:57:51.768765Z","steps":["trace[777934715] 'read index received'  (duration: 145.204416ms)","trace[777934715] 'applied index is now lower than readState.Index'  (duration: 131.234332ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:51.76885Z","caller":"traceutil/trace.go:171","msg":"trace[42198702] transaction","detail":"{read_only:false; response_revision:24547; number_of_response:1; }","duration":"424.086911ms","start":"2026-05-08T23:57:51.344752Z","end":"2026-05-08T23:57:51.768839Z","steps":["trace[42198702] 'process raft request'  (duration: 292.555881ms)","trace[42198702] 'compare'  (duration: 130.799032ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:51.769084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.606698ms","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-08T23:57:51.769151Z","caller":"traceutil/trace.go:171","msg":"trace[1090312384] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24547; }","duration":"293.714861ms","start":"2026-05-08T23:57:51.475419Z","end":"2026-05-08T23:57:51.769134Z","steps":["trace[1090312384] 'agreement among raft nodes before linearized reading'  (duration: 293.602218ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.76949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.286501ms","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-08T23:57:51.769561Z","caller":"traceutil/trace.go:171","msg":"trace[1039454621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24547; }","duration":"415.391413ms","start":"2026-05-08T23:57:51.354159Z","end":"2026-05-08T23:57:51.76955Z","steps":["trace[1039454621] 'agreement among raft nodes before linearized reading'  (duration: 414.873371ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:51.769601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.354147Z","time spent":"415.446744ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-08T23:57:51.769883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.344729Z","time spent":"424.164613ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24509 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T23:57:52.053183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.290047ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459231 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/poddisruptionbudgets/openstack/magnum-api\" mod_revision:23089 > success:<request_put:<key:\"/registry/poddisruptionbudgets/openstack/magnum-api\" value_size:1033 >> failure:<request_range:<key:\"/registry/poddisruptionbudgets/openstack/magnum-api\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:52.053392Z","caller":"traceutil/trace.go:171","msg":"trace[414080299] transaction","detail":"{read_only:false; response_revision:24548; number_of_response:1; }","duration":"550.509719ms","start":"2026-05-08T23:57:51.502862Z","end":"2026-05-08T23:57:52.053372Z","steps":["trace[414080299] 'process raft request'  (duration: 389.961227ms)","trace[414080299] 'compare'  (duration: 160.191854ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:52.053478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.502846Z","time spent":"550.601162ms","remote":"127.0.0.1:50614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/poddisruptionbudgets/openstack/magnum-api\" mod_revision:23089 > success:<request_put:<key:\"/registry/poddisruptionbudgets/openstack/magnum-api\" value_size:1033 >> failure:<request_range:<key:\"/registry/poddisruptionbudgets/openstack/magnum-api\" > >"}
{"level":"info","ts":"2026-05-08T23:57:52.05363Z","caller":"traceutil/trace.go:171","msg":"trace[1882010043] transaction","detail":"{read_only:false; response_revision:24549; number_of_response:1; }","duration":"550.602551ms","start":"2026-05-08T23:57:51.50302Z","end":"2026-05-08T23:57:52.053623Z","steps":["trace[1882010043] 'process raft request'  (duration: 550.250553ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:52.053666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.502982Z","time spent":"550.663223ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":652,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/magnum-api\" mod_revision:23138 > success:<request_put:<key:\"/registry/services/endpoints/openstack/magnum-api\" value_size:595 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/magnum-api\" > >"}
{"level":"info","ts":"2026-05-08T23:57:52.053795Z","caller":"traceutil/trace.go:171","msg":"trace[146125460] transaction","detail":"{read_only:false; response_revision:24550; number_of_response:1; }","duration":"550.683194ms","start":"2026-05-08T23:57:51.503095Z","end":"2026-05-08T23:57:52.053779Z","steps":["trace[146125460] 'process raft request'  (duration: 550.241583ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:52.053871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.502984Z","time spent":"550.845297ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24532 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-08T23:57:52.054254Z","caller":"traceutil/trace.go:171","msg":"trace[151248697] linearizableReadLoop","detail":"{readStateIndex:25347; appliedIndex:25342; }","duration":"285.430693ms","start":"2026-05-08T23:57:51.768811Z","end":"2026-05-08T23:57:52.054242Z","steps":["trace[151248697] 'read index received'  (duration: 123.986869ms)","trace[151248697] 'applied index is now lower than readState.Index'  (duration: 161.440954ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:52.054344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.50398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:52.054375Z","caller":"traceutil/trace.go:171","msg":"trace[188689638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24552; }","duration":"514.563922ms","start":"2026-05-08T23:57:51.539803Z","end":"2026-05-08T23:57:52.054367Z","steps":["trace[188689638] 'agreement among raft nodes before linearized reading'  (duration: 514.4907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:52.054547Z","caller":"traceutil/trace.go:171","msg":"trace[2085850302] transaction","detail":"{read_only:false; response_revision:24551; number_of_response:1; }","duration":"551.427741ms","start":"2026-05-08T23:57:51.503102Z","end":"2026-05-08T23:57:52.05453Z","steps":["trace[2085850302] 'process raft request'  (duration: 550.296925ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:52.054629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.503096Z","time spent":"551.489583ms","remote":"127.0.0.1:50788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7461,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/replicasets/openstack/magnum-api-7488f748b5\" mod_revision:23094 > success:<request_put:<key:\"/registry/replicasets/openstack/magnum-api-7488f748b5\" value_size:7400 >> failure:<request_range:<key:\"/registry/replicasets/openstack/magnum-api-7488f748b5\" > >"}
{"level":"info","ts":"2026-05-08T23:57:52.05474Z","caller":"traceutil/trace.go:171","msg":"trace[1563753598] transaction","detail":"{read_only:false; response_revision:24552; number_of_response:1; }","duration":"551.581434ms","start":"2026-05-08T23:57:51.503148Z","end":"2026-05-08T23:57:52.054729Z","steps":["trace[1563753598] 'process raft request'  (duration: 551.031061ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:52.0548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.502982Z","time spent":"551.789229ms","remote":"127.0.0.1:50570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1167,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/magnum-api-n4kff\" mod_revision:23139 > success:<request_put:<key:\"/registry/endpointslices/openstack/magnum-api-n4kff\" value_size:1108 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/magnum-api-n4kff\" > >"}
{"level":"warn","ts":"2026-05-08T23:57:52.054403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:51.539754Z","time spent":"514.643273ms","remote":"127.0.0.1:50284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-08T23:57:52.064232Z","caller":"traceutil/trace.go:171","msg":"trace[467256606] transaction","detail":"{read_only:false; response_revision:24553; number_of_response:1; }","duration":"292.092132ms","start":"2026-05-08T23:57:51.772127Z","end":"2026-05-08T23:57:52.064219Z","steps":["trace[467256606] 'process raft request'  (duration: 291.914407ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:52.064459Z","caller":"traceutil/trace.go:171","msg":"trace[240632403] transaction","detail":"{read_only:false; response_revision:24554; number_of_response:1; }","duration":"240.533731ms","start":"2026-05-08T23:57:51.823654Z","end":"2026-05-08T23:57:52.064188Z","steps":["trace[240632403] 'process raft request'  (duration: 240.46809ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:52.280718Z","caller":"traceutil/trace.go:171","msg":"trace[880164936] transaction","detail":"{read_only:false; response_revision:24555; number_of_response:1; }","duration":"218.71696ms","start":"2026-05-08T23:57:52.061972Z","end":"2026-05-08T23:57:52.280689Z","steps":["trace[880164936] 'process raft request'  (duration: 198.847366ms)","trace[880164936] 'compare'  (duration: 19.118036ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:52.588675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.878755ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459244 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:24480 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:52.588756Z","caller":"traceutil/trace.go:171","msg":"trace[325027805] linearizableReadLoop","detail":"{readStateIndex:25353; appliedIndex:25352; }","duration":"175.372006ms","start":"2026-05-08T23:57:52.413374Z","end":"2026-05-08T23:57:52.588746Z","steps":["trace[325027805] 'read index received'  (duration: 36.304586ms)","trace[325027805] 'applied index is now lower than readState.Index'  (duration: 139.06678ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:52.588808Z","caller":"traceutil/trace.go:171","msg":"trace[1034416594] transaction","detail":"{read_only:false; response_revision:24558; number_of_response:1; }","duration":"255.858727ms","start":"2026-05-08T23:57:52.332943Z","end":"2026-05-08T23:57:52.588802Z","steps":["trace[1034416594] 'process raft request'  (duration: 116.791868ms)","trace[1034416594] 'compare'  (duration: 138.741771ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:52.589055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.682674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-08T23:57:52.589094Z","caller":"traceutil/trace.go:171","msg":"trace[262023129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24558; }","duration":"175.756784ms","start":"2026-05-08T23:57:52.413326Z","end":"2026-05-08T23:57:52.589083Z","steps":["trace[262023129] 'agreement among raft nodes before linearized reading'  (duration: 175.644302ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:52.896005Z","caller":"traceutil/trace.go:171","msg":"trace[837041761] transaction","detail":"{read_only:false; response_revision:24559; number_of_response:1; }","duration":"301.799912ms","start":"2026-05-08T23:57:52.594172Z","end":"2026-05-08T23:57:52.895972Z","steps":["trace[837041761] 'process raft request'  (duration: 301.564137ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:52.896172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.594148Z","time spent":"301.934826ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24538 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-08T23:57:53.073795Z","caller":"traceutil/trace.go:171","msg":"trace[252868865] transaction","detail":"{read_only:false; response_revision:24562; number_of_response:1; }","duration":"319.958856ms","start":"2026-05-08T23:57:52.753806Z","end":"2026-05-08T23:57:53.073765Z","steps":["trace[252868865] 'process raft request'  (duration: 319.537486ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:53.074075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.595409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:53.074112Z","caller":"traceutil/trace.go:171","msg":"trace[1137627242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:24565; }","duration":"348.685661ms","start":"2026-05-08T23:57:52.725419Z","end":"2026-05-08T23:57:53.074105Z","steps":["trace[1137627242] 'agreement among raft nodes before linearized reading'  (duration: 348.579369ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:53.074136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.725399Z","time spent":"348.731573ms","remote":"127.0.0.1:49144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:57:53.074318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.75378Z","time spent":"320.287484ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24541 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T23:57:53.073919Z","caller":"traceutil/trace.go:171","msg":"trace[117321438] transaction","detail":"{read_only:false; response_revision:24563; number_of_response:1; }","duration":"319.775342ms","start":"2026-05-08T23:57:52.754115Z","end":"2026-05-08T23:57:53.073891Z","steps":["trace[117321438] 'process raft request'  (duration: 319.26576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:53.074504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.7541Z","time spent":"320.359806ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24543 > 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-08T23:57:53.073969Z","caller":"traceutil/trace.go:171","msg":"trace[197444184] transaction","detail":"{read_only:false; response_revision:24564; number_of_response:1; }","duration":"318.951253ms","start":"2026-05-08T23:57:52.755013Z","end":"2026-05-08T23:57:53.073964Z","steps":["trace[197444184] 'process raft request'  (duration: 318.431691ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:53.074573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.754988Z","time spent":"319.568687ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24542 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-08T23:57:53.07399Z","caller":"traceutil/trace.go:171","msg":"trace[716160255] linearizableReadLoop","detail":"{readStateIndex:25355; appliedIndex:25353; }","duration":"348.509988ms","start":"2026-05-08T23:57:52.725473Z","end":"2026-05-08T23:57:53.073983Z","steps":["trace[716160255] 'read index received'  (duration: 170.290024ms)","trace[716160255] 'applied index is now lower than readState.Index'  (duration: 178.218713ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:53.074663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.805758ms","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-08T23:57:53.074685Z","caller":"traceutil/trace.go:171","msg":"trace[1712116225] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24565; }","duration":"279.86224ms","start":"2026-05-08T23:57:52.794817Z","end":"2026-05-08T23:57:53.07468Z","steps":["trace[1712116225] 'agreement among raft nodes before linearized reading'  (duration: 279.823379ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:53.074831Z","caller":"traceutil/trace.go:171","msg":"trace[392475669] transaction","detail":"{read_only:false; response_revision:24560; number_of_response:1; }","duration":"363.204247ms","start":"2026-05-08T23:57:52.711583Z","end":"2026-05-08T23:57:53.074787Z","steps":["trace[392475669] 'process raft request'  (duration: 335.781663ms)","trace[392475669] 'compare'  (duration: 25.51705ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:53.075122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.711564Z","time spent":"363.494275ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24539 > 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-08T23:57:53.074904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.725266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-05-08T23:57:53.075259Z","caller":"traceutil/trace.go:171","msg":"trace[143731893] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24565; }","duration":"156.129555ms","start":"2026-05-08T23:57:52.919122Z","end":"2026-05-08T23:57:53.075252Z","steps":["trace[143731893] 'agreement among raft nodes before linearized reading'  (duration: 155.736096ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:53.075011Z","caller":"traceutil/trace.go:171","msg":"trace[1777388722] transaction","detail":"{read_only:false; response_revision:24561; number_of_response:1; }","duration":"321.208726ms","start":"2026-05-08T23:57:52.753795Z","end":"2026-05-08T23:57:53.075004Z","steps":["trace[1777388722] 'process raft request'  (duration: 319.488975ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:53.075341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:52.753765Z","time spent":"321.549464ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24540 > 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-08T23:57:53.362843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.640074ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459257 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24545 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:53.363087Z","caller":"traceutil/trace.go:171","msg":"trace[860024932] transaction","detail":"{read_only:false; response_revision:24567; number_of_response:1; }","duration":"281.367355ms","start":"2026-05-08T23:57:53.081708Z","end":"2026-05-08T23:57:53.363075Z","steps":["trace[860024932] 'process raft request'  (duration: 281.270642ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:53.363255Z","caller":"traceutil/trace.go:171","msg":"trace[1524800580] transaction","detail":"{read_only:false; response_revision:24566; number_of_response:1; }","duration":"281.753914ms","start":"2026-05-08T23:57:53.081494Z","end":"2026-05-08T23:57:53.363248Z","steps":["trace[1524800580] 'process raft request'  (duration: 146.6673ms)","trace[1524800580] 'compare'  (duration: 134.429058ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:53.685379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.925168ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459260 > lease_revoke:<id:73eb9e09dbb4fe88>","response":"size:30"}
{"level":"info","ts":"2026-05-08T23:57:53.685455Z","caller":"traceutil/trace.go:171","msg":"trace[1757629286] linearizableReadLoop","detail":"{readStateIndex:25363; appliedIndex:25362; }","duration":"255.068048ms","start":"2026-05-08T23:57:53.430376Z","end":"2026-05-08T23:57:53.685444Z","steps":["trace[1757629286] 'read index received'  (duration: 30.004867ms)","trace[1757629286] 'applied index is now lower than readState.Index'  (duration: 225.062221ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:53.685509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.135159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:53.685529Z","caller":"traceutil/trace.go:171","msg":"trace[1934627422] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:24567; }","duration":"255.160259ms","start":"2026-05-08T23:57:53.43036Z","end":"2026-05-08T23:57:53.685521Z","steps":["trace[1934627422] 'agreement among raft nodes before linearized reading'  (duration: 255.111668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:54.201938Z","caller":"traceutil/trace.go:171","msg":"trace[111512593] transaction","detail":"{read_only:false; response_revision:24568; number_of_response:1; }","duration":"132.939903ms","start":"2026-05-08T23:57:54.068981Z","end":"2026-05-08T23:57:54.20192Z","steps":["trace[111512593] 'process raft request'  (duration: 132.83229ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:54.420633Z","caller":"traceutil/trace.go:171","msg":"trace[314250463] transaction","detail":"{read_only:false; response_revision:24570; number_of_response:1; }","duration":"132.643806ms","start":"2026-05-08T23:57:54.287967Z","end":"2026-05-08T23:57:54.420611Z","steps":["trace[314250463] 'process raft request'  (duration: 132.331669ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:54.420986Z","caller":"traceutil/trace.go:171","msg":"trace[1038038280] transaction","detail":"{read_only:false; response_revision:24569; number_of_response:1; }","duration":"351.775726ms","start":"2026-05-08T23:57:54.069197Z","end":"2026-05-08T23:57:54.420972Z","steps":["trace[1038038280] 'process raft request'  (duration: 313.052901ms)","trace[1038038280] 'compare'  (duration: 37.895315ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:54.421088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:54.069186Z","time spent":"351.833978ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24554 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T23:57:54.421227Z","caller":"traceutil/trace.go:171","msg":"trace[1176589375] linearizableReadLoop","detail":"{readStateIndex:25365; appliedIndex:25363; }","duration":"351.861038ms","start":"2026-05-08T23:57:54.069357Z","end":"2026-05-08T23:57:54.421218Z","steps":["trace[1176589375] 'read index received'  (duration: 132.454692ms)","trace[1176589375] 'applied index is now lower than readState.Index'  (duration: 219.405196ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:54.421488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.123635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-08T23:57:54.421527Z","caller":"traceutil/trace.go:171","msg":"trace[1437708558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24570; }","duration":"352.177955ms","start":"2026-05-08T23:57:54.069339Z","end":"2026-05-08T23:57:54.421517Z","steps":["trace[1437708558] 'agreement among raft nodes before linearized reading'  (duration: 352.058263ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:54.421558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:54.069333Z","time spent":"352.218676ms","remote":"127.0.0.1:50566","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-08T23:57:54.422005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.482125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-08T23:57:54.422044Z","caller":"traceutil/trace.go:171","msg":"trace[867513813] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24570; }","duration":"125.549297ms","start":"2026-05-08T23:57:54.296485Z","end":"2026-05-08T23:57:54.422034Z","steps":["trace[867513813] 'agreement among raft nodes before linearized reading'  (duration: 125.456784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:54.421972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.609418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"warn","ts":"2026-05-08T23:57:54.422158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.303258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:54.422274Z","caller":"traceutil/trace.go:171","msg":"trace[1528057390] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24570; }","duration":"228.446372ms","start":"2026-05-08T23:57:54.193767Z","end":"2026-05-08T23:57:54.422213Z","steps":["trace[1528057390] 'agreement among raft nodes before linearized reading'  (duration: 228.302628ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:54.422189Z","caller":"traceutil/trace.go:171","msg":"trace[1281054020] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24570; }","duration":"345.909005ms","start":"2026-05-08T23:57:54.07627Z","end":"2026-05-08T23:57:54.422179Z","steps":["trace[1281054020] 'agreement among raft nodes before linearized reading'  (duration: 345.398703ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:54.423542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:54.076254Z","time spent":"347.269278ms","remote":"127.0.0.1:48964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5676,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-08T23:57:54.707022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.473905ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459275 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24553 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:57:54.707189Z","caller":"traceutil/trace.go:171","msg":"trace[1333078975] linearizableReadLoop","detail":"{readStateIndex:25368; appliedIndex:25366; }","duration":"167.120599ms","start":"2026-05-08T23:57:54.540051Z","end":"2026-05-08T23:57:54.707172Z","steps":["trace[1333078975] 'read index received'  (duration: 20.534531ms)","trace[1333078975] 'applied index is now lower than readState.Index'  (duration: 146.585098ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:54.707264Z","caller":"traceutil/trace.go:171","msg":"trace[1645433773] transaction","detail":"{read_only:false; response_revision:24571; number_of_response:1; }","duration":"281.060027ms","start":"2026-05-08T23:57:54.42619Z","end":"2026-05-08T23:57:54.70725Z","steps":["trace[1645433773] 'process raft request'  (duration: 134.267114ms)","trace[1645433773] 'compare'  (duration: 146.206069ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:54.707326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.280833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:57:54.70736Z","caller":"traceutil/trace.go:171","msg":"trace[1256908330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24572; }","duration":"167.346485ms","start":"2026-05-08T23:57:54.540005Z","end":"2026-05-08T23:57:54.707352Z","steps":["trace[1256908330] 'agreement among raft nodes before linearized reading'  (duration: 167.291063ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:54.707277Z","caller":"traceutil/trace.go:171","msg":"trace[812266212] transaction","detail":"{read_only:false; response_revision:24572; number_of_response:1; }","duration":"280.763921ms","start":"2026-05-08T23:57:54.426504Z","end":"2026-05-08T23:57:54.707268Z","steps":["trace[812266212] 'process raft request'  (duration: 280.612387ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:54.70757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.374287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"}
{"level":"info","ts":"2026-05-08T23:57:54.707607Z","caller":"traceutil/trace.go:171","msg":"trace[1889592816] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24572; }","duration":"129.442299ms","start":"2026-05-08T23:57:54.578157Z","end":"2026-05-08T23:57:54.707599Z","steps":["trace[1889592816] 'agreement among raft nodes before linearized reading'  (duration: 129.327597ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:54.915961Z","caller":"traceutil/trace.go:171","msg":"trace[1088913441] transaction","detail":"{read_only:false; response_revision:24573; number_of_response:1; }","duration":"148.008923ms","start":"2026-05-08T23:57:54.767927Z","end":"2026-05-08T23:57:54.915936Z","steps":["trace[1088913441] 'process raft request'  (duration: 146.772623ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:55.298906Z","caller":"traceutil/trace.go:171","msg":"trace[1200905676] transaction","detail":"{read_only:false; response_revision:24575; number_of_response:1; }","duration":"214.981151ms","start":"2026-05-08T23:57:55.083899Z","end":"2026-05-08T23:57:55.29888Z","steps":["trace[1200905676] 'process raft request'  (duration: 214.814547ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:55.528865Z","caller":"traceutil/trace.go:171","msg":"trace[49047077] transaction","detail":"{read_only:false; response_revision:24576; number_of_response:1; }","duration":"444.789664ms","start":"2026-05-08T23:57:55.084048Z","end":"2026-05-08T23:57:55.528837Z","steps":["trace[49047077] 'process raft request'  (duration: 412.184827ms)","trace[49047077] 'compare'  (duration: 32.145417ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:57:55.528917Z","caller":"traceutil/trace.go:171","msg":"trace[333850199] transaction","detail":"{read_only:false; response_revision:24577; number_of_response:1; }","duration":"444.769775ms","start":"2026-05-08T23:57:55.084117Z","end":"2026-05-08T23:57:55.528887Z","steps":["trace[333850199] 'process raft request'  (duration: 444.602941ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:55.528963Z","caller":"traceutil/trace.go:171","msg":"trace[1657914359] transaction","detail":"{read_only:false; response_revision:24579; number_of_response:1; }","duration":"444.785665ms","start":"2026-05-08T23:57:55.084155Z","end":"2026-05-08T23:57:55.528941Z","steps":["trace[1657914359] 'process raft request'  (duration: 444.710353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:55.529047Z","caller":"traceutil/trace.go:171","msg":"trace[1674384755] linearizableReadLoop","detail":"{readStateIndex:25376; appliedIndex:25370; }","duration":"261.918851ms","start":"2026-05-08T23:57:55.267105Z","end":"2026-05-08T23:57:55.529024Z","steps":["trace[1674384755] 'read index received'  (duration: 31.700576ms)","trace[1674384755] 'applied index is now lower than readState.Index'  (duration: 230.216735ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:57:55.529077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:55.08407Z","time spent":"444.911528ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24563 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:57:55.5296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:55.084126Z","time spent":"445.39692ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24561 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-08T23:57:55.529142Z","caller":"traceutil/trace.go:171","msg":"trace[1867081768] transaction","detail":"{read_only:false; response_revision:24580; number_of_response:1; }","duration":"444.954118ms","start":"2026-05-08T23:57:55.084178Z","end":"2026-05-08T23:57:55.529132Z","steps":["trace[1867081768] 'process raft request'  (duration: 444.724003ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:55.529749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:55.08415Z","time spent":"445.569274ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24565 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-08T23:57:55.529759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.397341ms","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-08T23:57:55.529147Z","caller":"traceutil/trace.go:171","msg":"trace[982724112] transaction","detail":"{read_only:false; response_revision:24578; number_of_response:1; }","duration":"444.974169ms","start":"2026-05-08T23:57:55.084155Z","end":"2026-05-08T23:57:55.529129Z","steps":["trace[982724112] 'process raft request'  (duration: 444.668852ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:57:55.529809Z","caller":"traceutil/trace.go:171","msg":"trace[176672444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24580; }","duration":"163.474662ms","start":"2026-05-08T23:57:55.366321Z","end":"2026-05-08T23:57:55.529796Z","steps":["trace[176672444] 'agreement among raft nodes before linearized reading'  (duration: 163.321058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:55.529839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:55.084129Z","time spent":"445.687496ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24560 > 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-08T23:57:55.529167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.054974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T23:57:55.529902Z","caller":"traceutil/trace.go:171","msg":"trace[158750063] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:24580; }","duration":"262.835363ms","start":"2026-05-08T23:57:55.267057Z","end":"2026-05-08T23:57:55.529892Z","steps":["trace[158750063] 'agreement among raft nodes before linearized reading'  (duration: 262.029153ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:57:55.529389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:57:55.084037Z","time spent":"444.901008ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24564 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-08T23:58:02.623474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.69347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:02.623582Z","caller":"traceutil/trace.go:171","msg":"trace[1486458506] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:24626; }","duration":"187.849463ms","start":"2026-05-08T23:58:02.435704Z","end":"2026-05-08T23:58:02.623554Z","steps":["trace[1486458506] 'count revisions from in-memory index tree'  (duration: 187.598667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:02.623973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.07126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-05-08T23:58:02.624061Z","caller":"traceutil/trace.go:171","msg":"trace[693546763] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:24626; }","duration":"354.203703ms","start":"2026-05-08T23:58:02.269834Z","end":"2026-05-08T23:58:02.624037Z","steps":["trace[693546763] 'range keys from in-memory index tree'  (duration: 353.201279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:02.624114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:02.269821Z","time spent":"354.282105ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" "}
{"level":"warn","ts":"2026-05-08T23:58:02.624124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.586485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:02.62421Z","caller":"traceutil/trace.go:171","msg":"trace[1480678736] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:24626; }","duration":"352.713698ms","start":"2026-05-08T23:58:02.271471Z","end":"2026-05-08T23:58:02.624185Z","steps":["trace[1480678736] 'count revisions from in-memory index tree'  (duration: 352.500584ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:02.624276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:02.271462Z","time spent":"352.79748ms","remote":"127.0.0.1:37440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true "}
{"level":"info","ts":"2026-05-08T23:58:02.624437Z","caller":"traceutil/trace.go:171","msg":"trace[83845831] transaction","detail":"{read_only:false; response_revision:24627; number_of_response:1; }","duration":"175.840107ms","start":"2026-05-08T23:58:02.44855Z","end":"2026-05-08T23:58:02.62439Z","steps":["trace[83845831] 'process raft request'  (duration: 87.279434ms)","trace[83845831] 'compare'  (duration: 87.653242ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:02.624485Z","caller":"traceutil/trace.go:171","msg":"trace[525055116] transaction","detail":"{read_only:false; response_revision:24628; number_of_response:1; }","duration":"174.448814ms","start":"2026-05-08T23:58:02.450001Z","end":"2026-05-08T23:58:02.62445Z","steps":["trace[525055116] 'process raft request'  (duration: 174.29581ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:02.970525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.6895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-08T23:58:02.970624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.795239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T23:58:02.970628Z","caller":"traceutil/trace.go:171","msg":"trace[2133040640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24628; }","duration":"226.839573ms","start":"2026-05-08T23:58:02.743763Z","end":"2026-05-08T23:58:02.970602Z","steps":["trace[2133040640] 'range keys from in-memory index tree'  (duration: 226.466305ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:02.970683Z","caller":"traceutil/trace.go:171","msg":"trace[929908993] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:24628; }","duration":"163.863011ms","start":"2026-05-08T23:58:02.806805Z","end":"2026-05-08T23:58:02.970668Z","steps":["trace[929908993] 'count revisions from in-memory index tree'  (duration: 163.691197ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:02.97078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.556151ms","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-08T23:58:02.970889Z","caller":"traceutil/trace.go:171","msg":"trace[937769369] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24628; }","duration":"227.709185ms","start":"2026-05-08T23:58:02.74315Z","end":"2026-05-08T23:58:02.970859Z","steps":["trace[937769369] 'range keys from in-memory index tree'  (duration: 227.352196ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:03.426777Z","caller":"traceutil/trace.go:171","msg":"trace[1952034799] transaction","detail":"{read_only:false; response_revision:24629; number_of_response:1; }","duration":"522.943702ms","start":"2026-05-08T23:58:02.903817Z","end":"2026-05-08T23:58:03.426761Z","steps":["trace[1952034799] 'process raft request'  (duration: 522.809579ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.426907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:02.903795Z","time spent":"523.042863ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:24558 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-08T23:58:03.632542Z","caller":"traceutil/trace.go:171","msg":"trace[1043686287] transaction","detail":"{read_only:false; response_revision:24630; number_of_response:1; }","duration":"657.697277ms","start":"2026-05-08T23:58:02.974829Z","end":"2026-05-08T23:58:03.632527Z","steps":["trace[1043686287] 'process raft request'  (duration: 656.53477ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.632649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:02.974802Z","time spent":"657.79075ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24616 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-08T23:58:03.632961Z","caller":"traceutil/trace.go:171","msg":"trace[1384762572] transaction","detail":"{read_only:false; response_revision:24631; number_of_response:1; }","duration":"657.340258ms","start":"2026-05-08T23:58:02.975602Z","end":"2026-05-08T23:58:03.632943Z","steps":["trace[1384762572] 'process raft request'  (duration: 656.881917ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.633019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:02.975581Z","time spent":"657.40692ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24615 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-08T23:58:03.633008Z","caller":"traceutil/trace.go:171","msg":"trace[297274316] transaction","detail":"{read_only:false; response_revision:24632; number_of_response:1; }","duration":"306.003793ms","start":"2026-05-08T23:58:03.326973Z","end":"2026-05-08T23:58:03.632976Z","steps":["trace[297274316] 'process raft request'  (duration: 305.87212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.633174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:03.326946Z","time spent":"306.139436ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24618 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T23:58:03.646424Z","caller":"traceutil/trace.go:171","msg":"trace[1164442541] linearizableReadLoop","detail":"{readStateIndex:25427; appliedIndex:25425; }","duration":"670.881652ms","start":"2026-05-08T23:58:02.975525Z","end":"2026-05-08T23:58:03.646406Z","steps":["trace[1164442541] 'read index received'  (duration: 451.178918ms)","trace[1164442541] 'applied index is now lower than readState.Index'  (duration: 219.701363ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:03.646838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.282691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-08T23:58:03.646928Z","caller":"traceutil/trace.go:171","msg":"trace[1964878980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24632; }","duration":"671.419674ms","start":"2026-05-08T23:58:02.975488Z","end":"2026-05-08T23:58:03.646907Z","steps":["trace[1964878980] 'agreement among raft nodes before linearized reading'  (duration: 671.027245ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.646973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:02.975474Z","time spent":"671.490696ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-08T23:58:03.647523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.777819ms","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-08T23:58:03.647697Z","caller":"traceutil/trace.go:171","msg":"trace[1845747201] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24637; }","duration":"476.997704ms","start":"2026-05-08T23:58:03.170683Z","end":"2026-05-08T23:58:03.647681Z","steps":["trace[1845747201] 'agreement among raft nodes before linearized reading'  (duration: 476.767309ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.64835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:03.170665Z","time spent":"477.64454ms","remote":"127.0.0.1:39204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:03.647556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.030937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:03.648754Z","caller":"traceutil/trace.go:171","msg":"trace[1409217633] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:24637; }","duration":"181.283057ms","start":"2026-05-08T23:58:03.467454Z","end":"2026-05-08T23:58:03.648737Z","steps":["trace[1409217633] 'agreement among raft nodes before linearized reading'  (duration: 180.038927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.647575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.699682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:03.649036Z","caller":"traceutil/trace.go:171","msg":"trace[1831813852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24637; }","duration":"107.198548ms","start":"2026-05-08T23:58:03.541826Z","end":"2026-05-08T23:58:03.649025Z","steps":["trace[1831813852] 'agreement among raft nodes before linearized reading'  (duration: 105.705862ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.647576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.28993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:03.649263Z","caller":"traceutil/trace.go:171","msg":"trace[483919841] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/endpoints/; range_end:/registry/openstack.k-orc.cloud/endpoints0; response_count:0; response_revision:24637; }","duration":"470.9825ms","start":"2026-05-08T23:58:03.17827Z","end":"2026-05-08T23:58:03.649252Z","steps":["trace[483919841] 'agreement among raft nodes before linearized reading'  (duration: 469.261359ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:03.649305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:03.178238Z","time spent":"471.053652ms","remote":"127.0.0.1:50568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:04.148622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.782887ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921459432 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24617 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:58:04.148884Z","caller":"traceutil/trace.go:171","msg":"trace[146940836] linearizableReadLoop","detail":"{readStateIndex:25437; appliedIndex:25435; }","duration":"349.241514ms","start":"2026-05-08T23:58:03.799627Z","end":"2026-05-08T23:58:04.148868Z","steps":["trace[146940836] 'read index received'  (duration: 113.130459ms)","trace[146940836] 'applied index is now lower than readState.Index'  (duration: 236.110115ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:04.149124Z","caller":"traceutil/trace.go:171","msg":"trace[1874225799] transaction","detail":"{read_only:false; response_revision:24638; number_of_response:1; }","duration":"496.657334ms","start":"2026-05-08T23:58:03.652439Z","end":"2026-05-08T23:58:04.149096Z","steps":["trace[1874225799] 'process raft request'  (duration: 260.311873ms)","trace[1874225799] 'compare'  (duration: 235.375158ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:04.149147Z","caller":"traceutil/trace.go:171","msg":"trace[2113311451] transaction","detail":"{read_only:false; response_revision:24639; number_of_response:1; }","duration":"496.565921ms","start":"2026-05-08T23:58:03.652544Z","end":"2026-05-08T23:58:04.14911Z","steps":["trace[2113311451] 'process raft request'  (duration: 496.172962ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:04.149206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.771128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-08T23:58:04.149247Z","caller":"traceutil/trace.go:171","msg":"trace[568362461] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24639; }","duration":"269.84376ms","start":"2026-05-08T23:58:03.879392Z","end":"2026-05-08T23:58:04.149236Z","steps":["trace[568362461] 'agreement among raft nodes before linearized reading'  (duration: 269.710967ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:04.149272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:03.652419Z","time spent":"496.780146ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24617 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-08T23:58:04.149312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:03.65253Z","time spent":"496.694405ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24624 > 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-08T23:58:04.149277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.628955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-08T23:58:04.149406Z","caller":"traceutil/trace.go:171","msg":"trace[895165590] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:24639; }","duration":"349.805009ms","start":"2026-05-08T23:58:03.799584Z","end":"2026-05-08T23:58:04.149389Z","steps":["trace[895165590] 'agreement among raft nodes before linearized reading'  (duration: 349.50061ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:04.149509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:03.799563Z","time spent":"349.905841ms","remote":"127.0.0.1:50398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":142,"response size":33,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:04.546402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.827585ms","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-08T23:58:04.546527Z","caller":"traceutil/trace.go:171","msg":"trace[866196135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24639; }","duration":"256.00799ms","start":"2026-05-08T23:58:04.290501Z","end":"2026-05-08T23:58:04.546509Z","steps":["trace[866196135] 'count revisions from in-memory index tree'  (duration: 255.737344ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:04.546659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.776583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-08T23:58:04.546688Z","caller":"traceutil/trace.go:171","msg":"trace[1443652426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24639; }","duration":"278.850165ms","start":"2026-05-08T23:58:04.267829Z","end":"2026-05-08T23:58:04.54668Z","steps":["trace[1443652426] 'range keys from in-memory index tree'  (duration: 278.625179ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:12.495178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.911864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:12.495265Z","caller":"traceutil/trace.go:171","msg":"trace[778538946] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:24757; }","duration":"193.041678ms","start":"2026-05-08T23:58:12.302205Z","end":"2026-05-08T23:58:12.495246Z","steps":["trace[778538946] 'count revisions from in-memory index tree'  (duration: 192.842702ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:12.495535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.229399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-263e0be4-3b42-4466-ae99-e52cc85e4142\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-05-08T23:58:12.495652Z","caller":"traceutil/trace.go:171","msg":"trace[551604035] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-263e0be4-3b42-4466-ae99-e52cc85e4142; range_end:; response_count:1; response_revision:24757; }","duration":"156.386783ms","start":"2026-05-08T23:58:12.339242Z","end":"2026-05-08T23:58:12.495628Z","steps":["trace[551604035] 'range keys from in-memory index tree'  (duration: 156.039804ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:12.769103Z","caller":"traceutil/trace.go:171","msg":"trace[539413866] transaction","detail":"{read_only:false; response_revision:24758; number_of_response:1; }","duration":"268.13539ms","start":"2026-05-08T23:58:12.500945Z","end":"2026-05-08T23:58:12.76908Z","steps":["trace[539413866] 'process raft request'  (duration: 268.008496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:12.769149Z","caller":"traceutil/trace.go:171","msg":"trace[1152473076] linearizableReadLoop","detail":"{readStateIndex:25557; appliedIndex:25557; }","duration":"230.565174ms","start":"2026-05-08T23:58:12.538543Z","end":"2026-05-08T23:58:12.769108Z","steps":["trace[1152473076] 'read index received'  (duration: 230.551694ms)","trace[1152473076] 'applied index is now lower than readState.Index'  (duration: 11.13µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:12.769449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.881571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:12.769496Z","caller":"traceutil/trace.go:171","msg":"trace[1359453165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24758; }","duration":"231.057385ms","start":"2026-05-08T23:58:12.538424Z","end":"2026-05-08T23:58:12.769482Z","steps":["trace[1359453165] 'agreement among raft nodes before linearized reading'  (duration: 230.947502ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.05455Z","caller":"traceutil/trace.go:171","msg":"trace[1749642902] linearizableReadLoop","detail":"{readStateIndex:25560; appliedIndex:25557; }","duration":"285.072463ms","start":"2026-05-08T23:58:12.76934Z","end":"2026-05-08T23:58:13.054413Z","steps":["trace[1749642902] 'read index received'  (duration: 200.417202ms)","trace[1749642902] 'applied index is now lower than readState.Index'  (duration: 84.654081ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:13.054702Z","caller":"traceutil/trace.go:171","msg":"trace[236218779] transaction","detail":"{read_only:false; response_revision:24761; number_of_response:1; }","duration":"308.881192ms","start":"2026-05-08T23:58:12.745795Z","end":"2026-05-08T23:58:13.054676Z","steps":["trace[236218779] 'process raft request'  (duration: 308.564174ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.054766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.041109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T23:58:13.05482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:12.745771Z","time spent":"308.988024ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24644 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-08T23:58:13.054822Z","caller":"traceutil/trace.go:171","msg":"trace[588937521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24761; }","duration":"284.122111ms","start":"2026-05-08T23:58:12.770682Z","end":"2026-05-08T23:58:13.054804Z","steps":["trace[588937521] 'agreement among raft nodes before linearized reading'  (duration: 284.014938ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.054816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.517943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:13.054877Z","caller":"traceutil/trace.go:171","msg":"trace[1521677147] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:24761; }","duration":"269.610825ms","start":"2026-05-08T23:58:12.785249Z","end":"2026-05-08T23:58:13.05486Z","steps":["trace[1521677147] 'agreement among raft nodes before linearized reading'  (duration: 269.494421ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.054893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.214905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-05-08T23:58:13.054883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.783442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T23:58:13.054931Z","caller":"traceutil/trace.go:171","msg":"trace[1503746417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24761; }","duration":"429.285937ms","start":"2026-05-08T23:58:12.625633Z","end":"2026-05-08T23:58:13.054919Z","steps":["trace[1503746417] 'agreement among raft nodes before linearized reading'  (duration: 429.164443ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.054967Z","caller":"traceutil/trace.go:171","msg":"trace[695875325] transaction","detail":"{read_only:false; response_revision:24760; number_of_response:1; }","duration":"396.690579ms","start":"2026-05-08T23:58:12.658269Z","end":"2026-05-08T23:58:13.05496Z","steps":["trace[695875325] 'process raft request'  (duration: 396.021022ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.054965Z","caller":"traceutil/trace.go:171","msg":"trace[714857051] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:24761; }","duration":"125.928645ms","start":"2026-05-08T23:58:12.929017Z","end":"2026-05-08T23:58:13.054945Z","steps":["trace[714857051] 'agreement among raft nodes before linearized reading'  (duration: 125.678918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.055009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.470522ms","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-08T23:58:13.055047Z","caller":"traceutil/trace.go:171","msg":"trace[825135354] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24761; }","duration":"481.530323ms","start":"2026-05-08T23:58:12.573505Z","end":"2026-05-08T23:58:13.055035Z","steps":["trace[825135354] 'agreement among raft nodes before linearized reading'  (duration: 481.480712ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.054838Z","caller":"traceutil/trace.go:171","msg":"trace[837354350] transaction","detail":"{read_only:false; response_revision:24759; number_of_response:1; }","duration":"398.405418ms","start":"2026-05-08T23:58:12.656366Z","end":"2026-05-08T23:58:13.054772Z","steps":["trace[837354350] 'process raft request'  (duration: 313.300757ms)","trace[837354350] 'compare'  (duration: 84.22078ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:13.055076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:12.573489Z","time spent":"481.579624ms","remote":"127.0.0.1:50104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:13.054965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:12.625616Z","time spent":"429.341657ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-08T23:58:13.055011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:12.658257Z","time spent":"396.733529ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24689 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-08T23:58:13.054768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.661567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:13.055205Z","caller":"traceutil/trace.go:171","msg":"trace[225852595] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:24761; }","duration":"493.12802ms","start":"2026-05-08T23:58:12.562048Z","end":"2026-05-08T23:58:13.055176Z","steps":["trace[225852595] 'agreement among raft nodes before linearized reading'  (duration: 492.634487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.055277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:12.562029Z","time spent":"493.224531ms","remote":"127.0.0.1:55942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:13.055264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:12.656338Z","time spent":"398.751738ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24688 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T23:58:13.631444Z","caller":"traceutil/trace.go:171","msg":"trace[1407112702] transaction","detail":"{read_only:false; response_revision:24764; number_of_response:1; }","duration":"220.235266ms","start":"2026-05-08T23:58:13.41118Z","end":"2026-05-08T23:58:13.631416Z","steps":["trace[1407112702] 'process raft request'  (duration: 207.541413ms)","trace[1407112702] 'compare'  (duration: 12.402356ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:13.631524Z","caller":"traceutil/trace.go:171","msg":"trace[197115247] linearizableReadLoop","detail":"{readStateIndex:25563; appliedIndex:25562; }","duration":"219.337245ms","start":"2026-05-08T23:58:13.412165Z","end":"2026-05-08T23:58:13.631502Z","steps":["trace[197115247] 'read index received'  (duration: 206.569281ms)","trace[197115247] 'applied index is now lower than readState.Index'  (duration: 12.766884ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:13.720806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.609555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1446"}
{"level":"info","ts":"2026-05-08T23:58:13.720888Z","caller":"traceutil/trace.go:171","msg":"trace[562294326] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24764; }","duration":"308.726029ms","start":"2026-05-08T23:58:13.41214Z","end":"2026-05-08T23:58:13.720866Z","steps":["trace[562294326] 'agreement among raft nodes before linearized reading'  (duration: 219.525779ms)","trace[562294326] 'range keys from in-memory index tree'  (duration: 88.981444ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:13.720934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:13.412129Z","time spent":"308.79616ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1470,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"warn","ts":"2026-05-08T23:58:13.720925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.340258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T23:58:13.720925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.438364ms","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-08T23:58:13.720984Z","caller":"traceutil/trace.go:171","msg":"trace[1360563137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24764; }","duration":"181.426379ms","start":"2026-05-08T23:58:13.539542Z","end":"2026-05-08T23:58:13.720968Z","steps":["trace[1360563137] 'agreement among raft nodes before linearized reading'  (duration: 181.339187ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.720987Z","caller":"traceutil/trace.go:171","msg":"trace[599189789] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:24764; }","duration":"133.515426ms","start":"2026-05-08T23:58:13.587458Z","end":"2026-05-08T23:58:13.720974Z","steps":["trace[599189789] 'agreement among raft nodes before linearized reading'  (duration: 133.402843ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.721038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.058089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-263e0be4-3b42-4466-ae99-e52cc85e4142\" ","response":"range_response_count:1 size:3760"}
{"level":"info","ts":"2026-05-08T23:58:13.721164Z","caller":"traceutil/trace.go:171","msg":"trace[510103571] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-263e0be4-3b42-4466-ae99-e52cc85e4142; range_end:; response_count:1; response_revision:24764; }","duration":"222.216233ms","start":"2026-05-08T23:58:13.498923Z","end":"2026-05-08T23:58:13.721139Z","steps":["trace[510103571] 'agreement among raft nodes before linearized reading'  (duration: 221.947717ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.855902Z","caller":"traceutil/trace.go:171","msg":"trace[247343569] transaction","detail":"{read_only:false; response_revision:24765; number_of_response:1; }","duration":"191.9173ms","start":"2026-05-08T23:58:13.66396Z","end":"2026-05-08T23:58:13.855877Z","steps":["trace[247343569] 'process raft request'  (duration: 191.763686ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.910309Z","caller":"traceutil/trace.go:171","msg":"trace[101903886] linearizableReadLoop","detail":"{readStateIndex:25570; appliedIndex:25564; }","duration":"189.657827ms","start":"2026-05-08T23:58:13.720626Z","end":"2026-05-08T23:58:13.910284Z","steps":["trace[101903886] 'read index received'  (duration: 135.206777ms)","trace[101903886] 'applied index is now lower than readState.Index'  (duration: 54.44951ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:13.910655Z","caller":"traceutil/trace.go:171","msg":"trace[1057353495] transaction","detail":"{read_only:false; response_revision:24771; number_of_response:1; }","duration":"105.871237ms","start":"2026-05-08T23:58:13.804734Z","end":"2026-05-08T23:58:13.910605Z","steps":["trace[1057353495] 'process raft request'  (duration: 105.495198ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.9107Z","caller":"traceutil/trace.go:171","msg":"trace[474913013] transaction","detail":"{read_only:false; response_revision:24768; number_of_response:1; }","duration":"221.293361ms","start":"2026-05-08T23:58:13.68937Z","end":"2026-05-08T23:58:13.910663Z","steps":["trace[474913013] 'process raft request'  (duration: 220.743869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.91085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.097135ms","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-08T23:58:13.910918Z","caller":"traceutil/trace.go:171","msg":"trace[1621621553] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24771; }","duration":"223.222708ms","start":"2026-05-08T23:58:13.687675Z","end":"2026-05-08T23:58:13.910898Z","steps":["trace[1621621553] 'agreement among raft nodes before linearized reading'  (duration: 223.030463ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.911126Z","caller":"traceutil/trace.go:171","msg":"trace[1835535360] transaction","detail":"{read_only:false; response_revision:24769; number_of_response:1; }","duration":"221.616919ms","start":"2026-05-08T23:58:13.689489Z","end":"2026-05-08T23:58:13.911106Z","steps":["trace[1835535360] 'process raft request'  (duration: 220.659646ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.911143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.381739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-08T23:58:13.911154Z","caller":"traceutil/trace.go:171","msg":"trace[920994117] transaction","detail":"{read_only:false; response_revision:24766; number_of_response:1; }","duration":"222.895949ms","start":"2026-05-08T23:58:13.688225Z","end":"2026-05-08T23:58:13.91112Z","steps":["trace[920994117] 'process raft request'  (duration: 221.693181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.91121Z","caller":"traceutil/trace.go:171","msg":"trace[2045374433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24771; }","duration":"225.479161ms","start":"2026-05-08T23:58:13.685716Z","end":"2026-05-08T23:58:13.911196Z","steps":["trace[2045374433] 'agreement among raft nodes before linearized reading'  (duration: 225.336488ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.911209Z","caller":"traceutil/trace.go:171","msg":"trace[447491432] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"218.426673ms","start":"2026-05-08T23:58:13.692745Z","end":"2026-05-08T23:58:13.911171Z","steps":["trace[447491432] 'process raft request'  (duration: 217.43909ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:13.91133Z","caller":"traceutil/trace.go:171","msg":"trace[2097838745] transaction","detail":"{read_only:false; response_revision:24767; number_of_response:1; }","duration":"222.985031ms","start":"2026-05-08T23:58:13.688329Z","end":"2026-05-08T23:58:13.911314Z","steps":["trace[2097838745] 'process raft request'  (duration: 221.739731ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.911394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.667334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:13.911458Z","caller":"traceutil/trace.go:171","msg":"trace[450496061] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:24771; }","duration":"261.760687ms","start":"2026-05-08T23:58:13.649683Z","end":"2026-05-08T23:58:13.911444Z","steps":["trace[450496061] 'agreement among raft nodes before linearized reading'  (duration: 261.666565ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:13.911462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.882067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"}
{"level":"info","ts":"2026-05-08T23:58:13.911521Z","caller":"traceutil/trace.go:171","msg":"trace[2093635067] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24771; }","duration":"175.98156ms","start":"2026-05-08T23:58:13.735523Z","end":"2026-05-08T23:58:13.911505Z","steps":["trace[2093635067] 'agreement among raft nodes before linearized reading'  (duration: 175.754095ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.045411Z","caller":"traceutil/trace.go:171","msg":"trace[200428315] transaction","detail":"{read_only:false; response_revision:24832; number_of_response:1; }","duration":"134.202533ms","start":"2026-05-08T23:58:19.911182Z","end":"2026-05-08T23:58:20.045385Z","steps":["trace[200428315] 'process raft request'  (duration: 133.782493ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.164678Z","caller":"traceutil/trace.go:171","msg":"trace[1972812023] transaction","detail":"{read_only:false; response_revision:24833; number_of_response:1; }","duration":"180.59466ms","start":"2026-05-08T23:58:19.984062Z","end":"2026-05-08T23:58:20.164656Z","steps":["trace[1972812023] 'process raft request'  (duration: 180.437216ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.164862Z","caller":"traceutil/trace.go:171","msg":"trace[1371780002] transaction","detail":"{read_only:false; response_revision:24834; number_of_response:1; }","duration":"178.170793ms","start":"2026-05-08T23:58:19.98668Z","end":"2026-05-08T23:58:20.164851Z","steps":["trace[1371780002] 'process raft request'  (duration: 177.939807ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.165066Z","caller":"traceutil/trace.go:171","msg":"trace[1085606407] transaction","detail":"{read_only:false; response_revision:24836; number_of_response:1; }","duration":"176.754868ms","start":"2026-05-08T23:58:19.9883Z","end":"2026-05-08T23:58:20.165055Z","steps":["trace[1085606407] 'process raft request'  (duration: 176.671726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.165096Z","caller":"traceutil/trace.go:171","msg":"trace[1330749410] linearizableReadLoop","detail":"{readStateIndex:25638; appliedIndex:25633; }","duration":"119.957314ms","start":"2026-05-08T23:58:20.045124Z","end":"2026-05-08T23:58:20.165081Z","steps":["trace[1330749410] 'read index received'  (duration: 119.365809ms)","trace[1330749410] 'applied index is now lower than readState.Index'  (duration: 590.495µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:20.165112Z","caller":"traceutil/trace.go:171","msg":"trace[1315707281] transaction","detail":"{read_only:false; response_revision:24837; number_of_response:1; }","duration":"171.999486ms","start":"2026-05-08T23:58:19.993092Z","end":"2026-05-08T23:58:20.165092Z","steps":["trace[1315707281] 'process raft request'  (duration: 171.929544ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.165164Z","caller":"traceutil/trace.go:171","msg":"trace[660870531] transaction","detail":"{read_only:false; response_revision:24835; number_of_response:1; }","duration":"177.140718ms","start":"2026-05-08T23:58:19.988014Z","end":"2026-05-08T23:58:20.165155Z","steps":["trace[660870531] 'process raft request'  (duration: 176.78836ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:20.165278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.922461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T23:58:20.165289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.872696ms","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-08T23:58:20.16531Z","caller":"traceutil/trace.go:171","msg":"trace[57118722] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24837; }","duration":"116.966792ms","start":"2026-05-08T23:58:20.048336Z","end":"2026-05-08T23:58:20.165303Z","steps":["trace[57118722] 'agreement among raft nodes before linearized reading'  (duration: 116.905231ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:20.165323Z","caller":"traceutil/trace.go:171","msg":"trace[870619540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24837; }","duration":"172.910927ms","start":"2026-05-08T23:58:19.992402Z","end":"2026-05-08T23:58:20.165313Z","steps":["trace[870619540] 'agreement among raft nodes before linearized reading'  (duration: 172.764644ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:20.165351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.00334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-08T23:58:20.165381Z","caller":"traceutil/trace.go:171","msg":"trace[774257571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24837; }","duration":"173.081272ms","start":"2026-05-08T23:58:19.992292Z","end":"2026-05-08T23:58:20.165373Z","steps":["trace[774257571] 'agreement among raft nodes before linearized reading'  (duration: 172.967689ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:33.44919Z","caller":"traceutil/trace.go:171","msg":"trace[936896199] linearizableReadLoop","detail":"{readStateIndex:25743; appliedIndex:25742; }","duration":"200.124667ms","start":"2026-05-08T23:58:33.249039Z","end":"2026-05-08T23:58:33.449163Z","steps":["trace[936896199] 'read index received'  (duration: 130.739101ms)","trace[936896199] 'applied index is now lower than readState.Index'  (duration: 69.384186ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:33.449429Z","caller":"traceutil/trace.go:171","msg":"trace[402372974] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"280.015593ms","start":"2026-05-08T23:58:33.169276Z","end":"2026-05-08T23:58:33.449292Z","steps":["trace[402372974] 'process raft request'  (duration: 210.447013ms)","trace[402372974] 'compare'  (duration: 69.234922ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:33.449445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.354512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:33.449801Z","caller":"traceutil/trace.go:171","msg":"trace[820920692] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:24940; }","duration":"200.723121ms","start":"2026-05-08T23:58:33.249001Z","end":"2026-05-08T23:58:33.449724Z","steps":["trace[820920692] 'agreement among raft nodes before linearized reading'  (duration: 200.299541ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:33.615836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.422904ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921460158 > lease_revoke:<id:73eb9e09dbb502a6>","response":"size:30"}
{"level":"info","ts":"2026-05-08T23:58:33.615947Z","caller":"traceutil/trace.go:171","msg":"trace[814559158] linearizableReadLoop","detail":"{readStateIndex:25744; appliedIndex:25743; }","duration":"166.669468ms","start":"2026-05-08T23:58:33.449258Z","end":"2026-05-08T23:58:33.615927Z","steps":["trace[814559158] 'read index received'  (duration: 20.07652ms)","trace[814559158] 'applied index is now lower than readState.Index'  (duration: 146.588938ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:33.616091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.907925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T23:58:33.616126Z","caller":"traceutil/trace.go:171","msg":"trace[1034780073] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:24940; }","duration":"231.989577ms","start":"2026-05-08T23:58:33.384127Z","end":"2026-05-08T23:58:33.616117Z","steps":["trace[1034780073] 'agreement among raft nodes before linearized reading'  (duration: 231.903345ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:33.616184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.85171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:33.616239Z","caller":"traceutil/trace.go:171","msg":"trace[870306111] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:24940; }","duration":"318.968553ms","start":"2026-05-08T23:58:33.297255Z","end":"2026-05-08T23:58:33.616223Z","steps":["trace[870306111] 'agreement among raft nodes before linearized reading'  (duration: 318.875541ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:33.616274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:33.297223Z","time spent":"319.039605ms","remote":"127.0.0.1:49036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:34.575587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.392748ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921460164 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24929 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:58:34.575739Z","caller":"traceutil/trace.go:171","msg":"trace[1775609365] transaction","detail":"{read_only:false; response_revision:24942; number_of_response:1; }","duration":"369.463678ms","start":"2026-05-08T23:58:34.206249Z","end":"2026-05-08T23:58:34.575713Z","steps":["trace[1775609365] 'process raft request'  (duration: 133.799034ms)","trace[1775609365] 'compare'  (duration: 234.916156ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:34.575817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.206227Z","time spent":"369.5566ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24929 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-08T23:58:34.726056Z","caller":"traceutil/trace.go:171","msg":"trace[1985899741] transaction","detail":"{read_only:false; response_revision:24943; number_of_response:1; }","duration":"517.590572ms","start":"2026-05-08T23:58:34.208434Z","end":"2026-05-08T23:58:34.726025Z","steps":["trace[1985899741] 'process raft request'  (duration: 496.09931ms)","trace[1985899741] 'compare'  (duration: 21.297097ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:34.726228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.208407Z","time spent":"517.733586ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24931 > 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-08T23:58:34.726304Z","caller":"traceutil/trace.go:171","msg":"trace[18798660] transaction","detail":"{read_only:false; response_revision:24944; number_of_response:1; }","duration":"517.114972ms","start":"2026-05-08T23:58:34.209165Z","end":"2026-05-08T23:58:34.72628Z","steps":["trace[18798660] 'process raft request'  (duration: 516.812314ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.726426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.209152Z","time spent":"517.211225ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24930 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-08T23:58:34.726636Z","caller":"traceutil/trace.go:171","msg":"trace[1610035307] transaction","detail":"{read_only:false; response_revision:24945; number_of_response:1; }","duration":"515.104424ms","start":"2026-05-08T23:58:34.211524Z","end":"2026-05-08T23:58:34.726628Z","steps":["trace[1610035307] 'process raft request'  (duration: 514.665123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.726675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.211513Z","time spent":"515.140305ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24932 > 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-08T23:58:34.726713Z","caller":"traceutil/trace.go:171","msg":"trace[980882008] linearizableReadLoop","detail":"{readStateIndex:25750; appliedIndex:25745; }","duration":"508.284742ms","start":"2026-05-08T23:58:34.218415Z","end":"2026-05-08T23:58:34.726699Z","steps":["trace[980882008] 'read index received'  (duration: 121.650674ms)","trace[980882008] 'applied index is now lower than readState.Index'  (duration: 386.632598ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:34.726688Z","caller":"traceutil/trace.go:171","msg":"trace[581790063] transaction","detail":"{read_only:false; response_revision:24946; number_of_response:1; }","duration":"512.81618ms","start":"2026-05-08T23:58:34.213839Z","end":"2026-05-08T23:58:34.726655Z","steps":["trace[581790063] 'process raft request'  (duration: 512.670586ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.726887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.213831Z","time spent":"512.974553ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24933 > 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-08T23:58:34.726921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.847859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T23:58:34.726988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.091316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-08T23:58:34.727014Z","caller":"traceutil/trace.go:171","msg":"trace[1670820223] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24947; }","duration":"446.135417ms","start":"2026-05-08T23:58:34.28087Z","end":"2026-05-08T23:58:34.727006Z","steps":["trace[1670820223] 'agreement among raft nodes before linearized reading'  (duration: 446.046945ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.727038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.28086Z","time spent":"446.174909ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-08T23:58:34.72703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.959127ms","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-08T23:58:34.727066Z","caller":"traceutil/trace.go:171","msg":"trace[1968937861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24947; }","duration":"447.029519ms","start":"2026-05-08T23:58:34.280025Z","end":"2026-05-08T23:58:34.727055Z","steps":["trace[1968937861] 'agreement among raft nodes before linearized reading'  (duration: 446.948517ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:34.727004Z","caller":"traceutil/trace.go:171","msg":"trace[706322629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24947; }","duration":"186.985552ms","start":"2026-05-08T23:58:34.54Z","end":"2026-05-08T23:58:34.726985Z","steps":["trace[706322629] 'agreement among raft nodes before linearized reading'  (duration: 186.87449ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.727099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.271314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-08T23:58:34.727103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.279996Z","time spent":"447.101081ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-08T23:58:34.727112Z","caller":"traceutil/trace.go:171","msg":"trace[1698982113] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:24947; }","duration":"395.327204ms","start":"2026-05-08T23:58:34.331781Z","end":"2026-05-08T23:58:34.727108Z","steps":["trace[1698982113] 'agreement among raft nodes before linearized reading'  (duration: 395.295574ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.727129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.331758Z","time spent":"395.367746ms","remote":"127.0.0.1:50702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T23:58:34.727147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.924327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-08T23:58:34.727181Z","caller":"traceutil/trace.go:171","msg":"trace[422147578] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24947; }","duration":"123.999759ms","start":"2026-05-08T23:58:34.603171Z","end":"2026-05-08T23:58:34.72717Z","steps":["trace[422147578] 'agreement among raft nodes before linearized reading'  (duration: 123.873216ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.726951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.770894ms","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-08T23:58:34.727327Z","caller":"traceutil/trace.go:171","msg":"trace[922207559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24947; }","duration":"486.163783ms","start":"2026-05-08T23:58:34.241148Z","end":"2026-05-08T23:58:34.727311Z","steps":["trace[922207559] 'agreement among raft nodes before linearized reading'  (duration: 485.693412ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.727384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.241139Z","time spent":"486.230784ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-08T23:58:34.727409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.072675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T23:58:34.727491Z","caller":"traceutil/trace.go:171","msg":"trace[1816654541] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:24947; }","duration":"161.208838ms","start":"2026-05-08T23:58:34.566264Z","end":"2026-05-08T23:58:34.727473Z","steps":["trace[1816654541] 'agreement among raft nodes before linearized reading'  (duration: 160.983663ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.72755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.126671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-08T23:58:34.727593Z","caller":"traceutil/trace.go:171","msg":"trace[801966030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24947; }","duration":"509.188123ms","start":"2026-05-08T23:58:34.218388Z","end":"2026-05-08T23:58:34.727576Z","steps":["trace[801966030] 'agreement among raft nodes before linearized reading'  (duration: 508.422285ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:34.727624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.218379Z","time spent":"509.237274ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-08T23:58:35.011626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.082404ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921460173 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24937 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:58:35.011743Z","caller":"traceutil/trace.go:171","msg":"trace[1282494925] transaction","detail":"{read_only:false; response_revision:24948; number_of_response:1; }","duration":"280.311231ms","start":"2026-05-08T23:58:34.731412Z","end":"2026-05-08T23:58:35.011724Z","steps":["trace[1282494925] 'process raft request'  (duration: 132.048942ms)","trace[1282494925] 'compare'  (duration: 147.790808ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:35.044277Z","caller":"traceutil/trace.go:171","msg":"trace[331882548] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"312.813106ms","start":"2026-05-08T23:58:34.731433Z","end":"2026-05-08T23:58:35.044247Z","steps":["trace[331882548] 'process raft request'  (duration: 312.5316ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:35.044303Z","caller":"traceutil/trace.go:171","msg":"trace[1438994172] transaction","detail":"{read_only:false; response_revision:24950; number_of_response:1; }","duration":"312.839767ms","start":"2026-05-08T23:58:34.731434Z","end":"2026-05-08T23:58:35.044273Z","steps":["trace[1438994172] 'process raft request'  (duration: 312.718944ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:35.044602Z","caller":"traceutil/trace.go:171","msg":"trace[2062141348] transaction","detail":"{read_only:false; response_revision:24951; number_of_response:1; }","duration":"312.636511ms","start":"2026-05-08T23:58:34.731892Z","end":"2026-05-08T23:58:35.044529Z","steps":["trace[2062141348] 'process raft request'  (duration: 312.336234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:35.0448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.731875Z","time spent":"312.829026ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24935 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-08T23:58:35.044424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.731416Z","time spent":"312.933139ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24934 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-08T23:58:35.044623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T23:58:34.731416Z","time spent":"313.076722ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24936 > 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-08T23:58:36.356192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.713396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"}
{"level":"info","ts":"2026-05-08T23:58:36.356247Z","caller":"traceutil/trace.go:171","msg":"trace[1711873024] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:24956; }","duration":"111.772218ms","start":"2026-05-08T23:58:36.244461Z","end":"2026-05-08T23:58:36.356233Z","steps":["trace[1711873024] 'range keys from in-memory index tree'  (duration: 111.605074ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:36.990146Z","caller":"traceutil/trace.go:171","msg":"trace[1363160909] linearizableReadLoop","detail":"{readStateIndex:25766; appliedIndex:25765; }","duration":"121.763936ms","start":"2026-05-08T23:58:36.868365Z","end":"2026-05-08T23:58:36.990129Z","steps":["trace[1363160909] 'read index received'  (duration: 121.586122ms)","trace[1363160909] 'applied index is now lower than readState.Index'  (duration: 177.094µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:36.990345Z","caller":"traceutil/trace.go:171","msg":"trace[1452100057] transaction","detail":"{read_only:false; response_revision:24962; number_of_response:1; }","duration":"159.775523ms","start":"2026-05-08T23:58:36.830561Z","end":"2026-05-08T23:58:36.990337Z","steps":["trace[1452100057] 'process raft request'  (duration: 159.444166ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:36.990537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.167877ms","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-08T23:58:36.990572Z","caller":"traceutil/trace.go:171","msg":"trace[1443435551] 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:24962; }","duration":"122.216218ms","start":"2026-05-08T23:58:36.868348Z","end":"2026-05-08T23:58:36.990564Z","steps":["trace[1443435551] 'agreement among raft nodes before linearized reading'  (duration: 122.150656ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:42.298759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.1431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-08T23:58:42.298864Z","caller":"traceutil/trace.go:171","msg":"trace[1170071149] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:25013; }","duration":"157.308984ms","start":"2026-05-08T23:58:42.14153Z","end":"2026-05-08T23:58:42.298839Z","steps":["trace[1170071149] 'count revisions from in-memory index tree'  (duration: 157.014657ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:42.521639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.275961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-856bb79bf8-rs6h8.18adbab4874e8c6b\" ","response":"range_response_count:1 size:1137"}
{"level":"info","ts":"2026-05-08T23:58:42.521725Z","caller":"traceutil/trace.go:171","msg":"trace[623538763] range","detail":"{range_begin:/registry/events/openstack/barbican-api-856bb79bf8-rs6h8.18adbab4874e8c6b; range_end:; response_count:1; response_revision:25014; }","duration":"110.406774ms","start":"2026-05-08T23:58:42.411297Z","end":"2026-05-08T23:58:42.521704Z","steps":["trace[623538763] 'range keys from in-memory index tree'  (duration: 110.114548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:43.382376Z","caller":"traceutil/trace.go:171","msg":"trace[626865360] linearizableReadLoop","detail":"{readStateIndex:25833; appliedIndex:25831; }","duration":"165.311875ms","start":"2026-05-08T23:58:43.217037Z","end":"2026-05-08T23:58:43.382349Z","steps":["trace[626865360] 'read index received'  (duration: 18.936752ms)","trace[626865360] 'applied index is now lower than readState.Index'  (duration: 146.373853ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:43.382607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.554932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-05-08T23:58:43.382593Z","caller":"traceutil/trace.go:171","msg":"trace[1727839271] transaction","detail":"{read_only:false; response_revision:25027; number_of_response:1; }","duration":"183.721655ms","start":"2026-05-08T23:58:43.198841Z","end":"2026-05-08T23:58:43.382562Z","steps":["trace[1727839271] 'process raft request'  (duration: 107.937225ms)","trace[1727839271] 'compare'  (duration: 75.435611ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:43.382657Z","caller":"traceutil/trace.go:171","msg":"trace[658259099] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:25027; }","duration":"165.625594ms","start":"2026-05-08T23:58:43.21702Z","end":"2026-05-08T23:58:43.382646Z","steps":["trace[658259099] 'agreement among raft nodes before linearized reading'  (duration: 165.451989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:44.968644Z","caller":"traceutil/trace.go:171","msg":"trace[1430109429] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"130.243079ms","start":"2026-05-08T23:58:44.838375Z","end":"2026-05-08T23:58:44.968619Z","steps":["trace[1430109429] 'process raft request'  (duration: 67.47291ms)","trace[1430109429] 'compare'  (duration: 62.440331ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:44.96882Z","caller":"traceutil/trace.go:171","msg":"trace[501106930] transaction","detail":"{read_only:false; response_revision:25033; number_of_response:1; }","duration":"127.724299ms","start":"2026-05-08T23:58:44.841067Z","end":"2026-05-08T23:58:44.968791Z","steps":["trace[501106930] 'process raft request'  (duration: 127.497293ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:45.169653Z","caller":"traceutil/trace.go:171","msg":"trace[555092785] linearizableReadLoop","detail":"{readStateIndex:25842; appliedIndex:25840; }","duration":"120.899506ms","start":"2026-05-08T23:58:45.048729Z","end":"2026-05-08T23:58:45.169628Z","steps":["trace[555092785] 'read index received'  (duration: 23.128983ms)","trace[555092785] 'applied index is now lower than readState.Index'  (duration: 97.769363ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:45.169683Z","caller":"traceutil/trace.go:171","msg":"trace[1339411821] transaction","detail":"{read_only:false; response_revision:25034; number_of_response:1; }","duration":"298.090744ms","start":"2026-05-08T23:58:44.87156Z","end":"2026-05-08T23:58:45.169651Z","steps":["trace[1339411821] 'process raft request'  (duration: 200.311921ms)","trace[1339411821] 'compare'  (duration: 97.557488ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:45.169795Z","caller":"traceutil/trace.go:171","msg":"trace[1104002616] transaction","detail":"{read_only:false; response_revision:25035; number_of_response:1; }","duration":"265.6879ms","start":"2026-05-08T23:58:44.904096Z","end":"2026-05-08T23:58:45.169784Z","steps":["trace[1104002616] 'process raft request'  (duration: 265.472895ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:58:45.170188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.432879ms","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-08T23:58:45.17029Z","caller":"traceutil/trace.go:171","msg":"trace[1164107486] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25035; }","duration":"121.544462ms","start":"2026-05-08T23:58:45.048722Z","end":"2026-05-08T23:58:45.170266Z","steps":["trace[1164107486] 'agreement among raft nodes before linearized reading'  (duration: 121.315646ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:58:49.599423Z","caller":"traceutil/trace.go:171","msg":"trace[1438598090] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"196.964121ms","start":"2026-05-08T23:58:49.402425Z","end":"2026-05-08T23:58:49.599389Z","steps":["trace[1438598090] 'process raft request'  (duration: 146.664411ms)","trace[1438598090] 'compare'  (duration: 50.022424ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:49.771116Z","caller":"traceutil/trace.go:171","msg":"trace[427705478] linearizableReadLoop","detail":"{readStateIndex:25879; appliedIndex:25878; }","duration":"146.612939ms","start":"2026-05-08T23:58:49.624475Z","end":"2026-05-08T23:58:49.771088Z","steps":["trace[427705478] 'read index received'  (duration: 90.11402ms)","trace[427705478] 'applied index is now lower than readState.Index'  (duration: 56.497339ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:58:49.771237Z","caller":"traceutil/trace.go:171","msg":"trace[186461208] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"167.465977ms","start":"2026-05-08T23:58:49.603729Z","end":"2026-05-08T23:58:49.771195Z","steps":["trace[186461208] 'process raft request'  (duration: 110.858066ms)","trace[186461208] 'compare'  (duration: 56.314494ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T23:58:49.77126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.752172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:58:49.771346Z","caller":"traceutil/trace.go:171","msg":"trace[1761133909] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25071; }","duration":"146.855584ms","start":"2026-05-08T23:58:49.624438Z","end":"2026-05-08T23:58:49.771294Z","steps":["trace[1761133909] 'agreement among raft nodes before linearized reading'  (duration: 146.751392ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T23:59:10.821574Z","caller":"traceutil/trace.go:171","msg":"trace[1076100374] transaction","detail":"{read_only:false; response_revision:25234; number_of_response:1; }","duration":"111.303636ms","start":"2026-05-08T23:59:10.710225Z","end":"2026-05-08T23:59:10.821529Z","steps":["trace[1076100374] 'process raft request'  (duration: 111.070201ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:11.114605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.857024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-08T23:59:11.1147Z","caller":"traceutil/trace.go:171","msg":"trace[1432139569] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:25234; }","duration":"206.000257ms","start":"2026-05-08T23:59:10.908679Z","end":"2026-05-08T23:59:11.114679Z","steps":["trace[1432139569] 'count revisions from in-memory index tree'  (duration: 205.736261ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T23:59:11.114984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.614979ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921460860 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25219 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-08T23:59:11.115236Z","caller":"traceutil/trace.go:171","msg":"trace[215503973] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"168.116403ms","start":"2026-05-08T23:59:10.947095Z","end":"2026-05-08T23:59:11.115212Z","steps":["trace[215503973] 'process raft request'  (duration: 34.202086ms)","trace[215503973] 'compare'  (duration: 133.351113ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T23:59:11.202074Z","caller":"traceutil/trace.go:171","msg":"trace[1997909071] transaction","detail":"{read_only:false; response_revision:25237; number_of_response:1; }","duration":"151.952806ms","start":"2026-05-08T23:59:11.050084Z","end":"2026-05-08T23:59:11.202037Z","steps":["trace[1997909071] 'process raft request'  (duration: 151.726581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:09.460382Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006883.wal"}
{"level":"info","ts":"2026-05-09T00:00:55.303028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23437}
{"level":"info","ts":"2026-05-09T00:00:55.437326Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23437,"took":"130.064205ms","hash":2449939262,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":37281792,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-05-09T00:00:55.43738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2449939262,"revision":23437,"compact-revision":20190}
{"level":"info","ts":"2026-05-09T00:00:56.564753Z","caller":"traceutil/trace.go:171","msg":"trace[748752154] transaction","detail":"{read_only:false; response_revision:26413; number_of_response:1; }","duration":"132.574564ms","start":"2026-05-09T00:00:56.432148Z","end":"2026-05-09T00:00:56.564723Z","steps":["trace[748752154] 'process raft request'  (duration: 132.377919ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:56.911276Z","caller":"traceutil/trace.go:171","msg":"trace[408524821] transaction","detail":"{read_only:false; response_revision:26414; number_of_response:1; }","duration":"175.019918ms","start":"2026-05-09T00:00:56.736225Z","end":"2026-05-09T00:00:56.911245Z","steps":["trace[408524821] 'process raft request'  (duration: 174.863704ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:57.144511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.069495ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576315735921464023 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26387 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T00:00:57.145785Z","caller":"traceutil/trace.go:171","msg":"trace[200374519] transaction","detail":"{read_only:false; response_revision:26415; number_of_response:1; }","duration":"213.068235ms","start":"2026-05-09T00:00:56.932568Z","end":"2026-05-09T00:00:57.145636Z","steps":["trace[200374519] 'process raft request'  (duration: 99.790311ms)","trace[200374519] 'compare'  (duration: 111.956062ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:57.34043Z","caller":"traceutil/trace.go:171","msg":"trace[2045881498] transaction","detail":"{read_only:false; response_revision:26416; number_of_response:1; }","duration":"130.137865ms","start":"2026-05-09T00:00:57.210266Z","end":"2026-05-09T00:00:57.340404Z","steps":["trace[2045881498] 'process raft request'  (duration: 130.010952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:00:57.348141Z","caller":"traceutil/trace.go:171","msg":"trace[1960107333] linearizableReadLoop","detail":"{readStateIndex:27254; appliedIndex:27252; }","duration":"134.620673ms","start":"2026-05-09T00:00:57.213504Z","end":"2026-05-09T00:00:57.348124Z","steps":["trace[1960107333] 'read index received'  (duration: 126.766595ms)","trace[1960107333] 'applied index is now lower than readState.Index'  (duration: 7.853138ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T00:00:57.348252Z","caller":"traceutil/trace.go:171","msg":"trace[1083143590] transaction","detail":"{read_only:false; response_revision:26417; number_of_response:1; }","duration":"137.203045ms","start":"2026-05-09T00:00:57.211043Z","end":"2026-05-09T00:00:57.348246Z","steps":["trace[1083143590] 'process raft request'  (duration: 136.982119ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T00:00:57.348609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.098634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9c1b6f91-28fd-43fc-8fee-1eb3bad6d65e\" ","response":"range_response_count:1 size:1318"}
{"level":"info","ts":"2026-05-09T00:00:57.348658Z","caller":"traceutil/trace.go:171","msg":"trace[1002113569] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9c1b6f91-28fd-43fc-8fee-1eb3bad6d65e; range_end:; response_count:1; response_revision:26417; }","duration":"135.155405ms","start":"2026-05-09T00:00:57.213493Z","end":"2026-05-09T00:00:57.348648Z","steps":["trace[1002113569] 'agreement among raft nodes before linearized reading'  (duration: 135.017112ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T00:05:55.308737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26399}
{"level":"info","ts":"2026-05-09T00:05:55.449887Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26399,"took":"136.665571ms","hash":82243184,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":34344960,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-09T00:05:55.449964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":82243184,"revision":26399,"compact-revision":23437}
{"level":"info","ts":"2026-05-09T00:06:03.494461Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T00:06:03.500062Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-09T00:06:03.500141Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-09T00:10:55.317211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29034}
{"level":"info","ts":"2026-05-09T00:10:55.458525Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29034,"took":"134.775876ms","hash":1613553097,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":30765056,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T00:10:55.458595Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1613553097,"revision":29034,"compact-revision":26399}
{"level":"info","ts":"2026-05-09T00:15:55.32416Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31253}
{"level":"info","ts":"2026-05-09T00:15:55.463514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31253,"took":"134.821108ms","hash":1678089637,"current-db-size-bytes":59109376,"current-db-size":"59 MB","current-db-size-in-use-bytes":31092736,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T00:15:55.463606Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1678089637,"revision":31253,"compact-revision":29034}
{"level":"info","ts":"2026-05-09T00:20:55.330418Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33558}
{"level":"info","ts":"2026-05-09T00:20:55.485732Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33558,"took":"149.937524ms","hash":2967931052,"current-db-size-bytes":60149760,"current-db-size":"60 MB","current-db-size-in-use-bytes":33288192,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-09T00:20:55.485823Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2967931052,"revision":33558,"compact-revision":31253}
{"level":"info","ts":"2026-05-09T00:25:55.34193Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35845}
{"level":"info","ts":"2026-05-09T00:25:55.488426Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35845,"took":"143.279375ms","hash":2037388785,"current-db-size-bytes":61046784,"current-db-size":"61 MB","current-db-size-in-use-bytes":31682560,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T00:25:55.488502Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2037388785,"revision":35845,"compact-revision":33558}
{"level":"info","ts":"2026-05-09T00:27:28.717622Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T00:27:28.721512Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-09T00:27:28.721596Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}