{"level":"warn","ts":"2026-06-06T17:04:03.306077Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-06-06T17:04:03.306155Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-06-06T17:04:03.306218Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-06-06T17:04:03.306232Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-06-06T17:04:03.306251Z","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-06-06T17:04:03.307049Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]}
{"level":"info","ts":"2026-06-06T17:04:03.307231Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-06-06T17:04:03.31502Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.521405ms"}
{"level":"info","ts":"2026-06-06T17:04:03.322056Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"}
{"level":"info","ts":"2026-06-06T17:04:03.32212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"}
{"level":"info","ts":"2026-06-06T17:04:03.322149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"}
{"level":"info","ts":"2026-06-06T17:04:03.322164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-06-06T17:04:03.322181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"}
{"level":"info","ts":"2026-06-06T17:04:03.322237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"warn","ts":"2026-06-06T17:04:03.332045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-06-06T17:04:03.335157Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-06-06T17:04:03.336556Z","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-06-06T17:04:03.338274Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-06-06T17:04:03.338781Z","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-06-06T17:04:03.338853Z","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-06-06T17:04:03.338863Z","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-06-06T17:04:03.338831Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-06-06T17:04:03.339507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"info","ts":"2026-06-06T17:04:03.339704Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-06-06T17:04:03.340605Z","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-06-06T17:04:03.340738Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-06-06T17:04:03.340817Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-06-06T17:04:03.340849Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-06-06T17:04:03.340864Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-06-06T17:04:03.422846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"}
{"level":"info","ts":"2026-06-06T17:04:03.422938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"}
{"level":"info","ts":"2026-06-06T17:04:03.422962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"}
{"level":"info","ts":"2026-06-06T17:04:03.422978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"}
{"level":"info","ts":"2026-06-06T17:04:03.422986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-06-06T17:04:03.422998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"}
{"level":"info","ts":"2026-06-06T17:04:03.423009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-06-06T17:04:03.423919Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-06T17:04:03.424946Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-06T17:04:03.424983Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-06T17:04:03.424997Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"}
{"level":"info","ts":"2026-06-06T17:04:03.425333Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-06-06T17:04:03.425357Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-06-06T17:04:03.425373Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-06T17:04:03.425554Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-06T17:04:03.425594Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-06T17:04:03.428104Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"}
{"level":"info","ts":"2026-06-06T17:04:03.428098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-06-06T17:04:27.327113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.337741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:04:27.327225Z","caller":"traceutil/trace.go:171","msg":"trace[643666969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:433; }","duration":"291.544926ms","start":"2026-06-06T17:04:27.035659Z","end":"2026-06-06T17:04:27.327204Z","steps":["trace[643666969] 'range keys from in-memory index tree'  (duration: 291.239778ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:04:27.327237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.856087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-06-06T17:04:27.327216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.182294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-06-06T17:04:27.327319Z","caller":"traceutil/trace.go:171","msg":"trace[1758191516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:433; }","duration":"115.9789ms","start":"2026-06-06T17:04:27.211324Z","end":"2026-06-06T17:04:27.327302Z","steps":["trace[1758191516] 'range keys from in-memory index tree'  (duration: 115.755014ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:04:27.327363Z","caller":"traceutil/trace.go:171","msg":"trace[681042580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:433; }","duration":"107.355218ms","start":"2026-06-06T17:04:27.219977Z","end":"2026-06-06T17:04:27.327332Z","steps":["trace[681042580] 'range keys from in-memory index tree'  (duration: 106.974669ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:04:27.327235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.580891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"}
{"level":"info","ts":"2026-06-06T17:04:27.327496Z","caller":"traceutil/trace.go:171","msg":"trace[709580635] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:433; }","duration":"131.878168ms","start":"2026-06-06T17:04:27.19557Z","end":"2026-06-06T17:04:27.327448Z","steps":["trace[709580635] 'range keys from in-memory index tree'  (duration: 131.447988ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:04:48.846327Z","caller":"traceutil/trace.go:171","msg":"trace[2135939279] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"123.063082ms","start":"2026-06-06T17:04:48.723247Z","end":"2026-06-06T17:04:48.84631Z","steps":["trace[2135939279] 'process raft request'  (duration: 122.95961ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:04:48.947179Z","caller":"traceutil/trace.go:171","msg":"trace[1826953967] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"125.46488ms","start":"2026-06-06T17:04:48.82169Z","end":"2026-06-06T17:04:48.947155Z","steps":["trace[1826953967] 'process raft request'  (duration: 124.931727ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:04:49.537776Z","caller":"traceutil/trace.go:171","msg":"trace[1606616220] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"125.284638ms","start":"2026-06-06T17:04:49.412464Z","end":"2026-06-06T17:04:49.537748Z","steps":["trace[1606616220] 'process raft request'  (duration: 123.597238ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:05:03.87395Z","caller":"traceutil/trace.go:171","msg":"trace[1369905023] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"144.366353ms","start":"2026-06-06T17:05:03.729537Z","end":"2026-06-06T17:05:03.873903Z","steps":["trace[1369905023] 'process raft request'  (duration: 140.692013ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:05:32.173427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.267651ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531429771 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1182 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-06T17:05:32.173711Z","caller":"traceutil/trace.go:171","msg":"trace[295448489] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"264.030322ms","start":"2026-06-06T17:05:31.909641Z","end":"2026-06-06T17:05:32.173671Z","steps":["trace[295448489] 'read index received'  (duration: 109.834238ms)","trace[295448489] 'applied index is now lower than readState.Index'  (duration: 154.187004ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:05:32.173696Z","caller":"traceutil/trace.go:171","msg":"trace[427503190] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"281.997782ms","start":"2026-06-06T17:05:31.891629Z","end":"2026-06-06T17:05:32.173627Z","steps":["trace[427503190] 'process raft request'  (duration: 127.722546ms)","trace[427503190] 'compare'  (duration: 152.258967ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:05:32.182779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.426698ms","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-06-06T17:05:32.182834Z","caller":"traceutil/trace.go:171","msg":"trace[1511651532] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1194; }","duration":"129.529ms","start":"2026-06-06T17:05:32.053291Z","end":"2026-06-06T17:05:32.18282Z","steps":["trace[1511651532] 'agreement among raft nodes before linearized reading'  (duration: 129.386317ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:05:32.182824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.168685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:05:32.182923Z","caller":"traceutil/trace.go:171","msg":"trace[1113378358] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1194; }","duration":"273.329399ms","start":"2026-06-06T17:05:31.909549Z","end":"2026-06-06T17:05:32.182878Z","steps":["trace[1113378358] 'agreement among raft nodes before linearized reading'  (duration: 264.247307ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:06:19.532861Z","caller":"traceutil/trace.go:171","msg":"trace[1768593982] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"159.569927ms","start":"2026-06-06T17:06:19.373263Z","end":"2026-06-06T17:06:19.532833Z","steps":["trace[1768593982] 'read index received'  (duration: 159.346922ms)","trace[1768593982] 'applied index is now lower than readState.Index'  (duration: 222.025µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:06:19.532978Z","caller":"traceutil/trace.go:171","msg":"trace[1202954979] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"327.48901ms","start":"2026-06-06T17:06:19.205473Z","end":"2026-06-06T17:06:19.532962Z","steps":["trace[1202954979] 'process raft request'  (duration: 327.153321ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:06:19.533103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.835235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-488e2e50-1737-4cd1-8875-70b8ac44c66e\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-06-06T17:06:19.53314Z","caller":"traceutil/trace.go:171","msg":"trace[1386392165] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-488e2e50-1737-4cd1-8875-70b8ac44c66e; range_end:; response_count:1; response_revision:1870; }","duration":"159.912747ms","start":"2026-06-06T17:06:19.373221Z","end":"2026-06-06T17:06:19.533134Z","steps":["trace[1386392165] 'agreement among raft nodes before linearized reading'  (duration: 159.787484ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:06:19.533106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:06:19.205446Z","time spent":"327.580733ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1812 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10913 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"info","ts":"2026-06-06T17:07:10.499293Z","caller":"traceutil/trace.go:171","msg":"trace[1183713591] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"107.806211ms","start":"2026-06-06T17:07:10.391447Z","end":"2026-06-06T17:07:10.499254Z","steps":["trace[1183713591] 'process raft request'  (duration: 107.573646ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:08:35.334617Z","caller":"traceutil/trace.go:171","msg":"trace[1697797265] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"128.191809ms","start":"2026-06-06T17:08:35.206397Z","end":"2026-06-06T17:08:35.334589Z","steps":["trace[1697797265] 'process raft request'  (duration: 128.019095ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:08:35.384143Z","caller":"traceutil/trace.go:171","msg":"trace[1312614046] transaction","detail":"{read_only:false; response_revision:2854; number_of_response:1; }","duration":"177.629228ms","start":"2026-06-06T17:08:35.206486Z","end":"2026-06-06T17:08:35.384116Z","steps":["trace[1312614046] 'process raft request'  (duration: 177.479684ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:08:35.915354Z","caller":"traceutil/trace.go:171","msg":"trace[794749093] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"116.634169ms","start":"2026-06-06T17:08:35.798686Z","end":"2026-06-06T17:08:35.91532Z","steps":["trace[794749093] 'process raft request'  (duration: 116.30152ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:11:05.615195Z","caller":"traceutil/trace.go:171","msg":"trace[1906626663] transaction","detail":"{read_only:false; response_revision:3843; number_of_response:1; }","duration":"107.582443ms","start":"2026-06-06T17:11:05.507582Z","end":"2026-06-06T17:11:05.615164Z","steps":["trace[1906626663] 'process raft request'  (duration: 107.375238ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:11:05.78132Z","caller":"traceutil/trace.go:171","msg":"trace[1896849933] transaction","detail":"{read_only:false; response_revision:3844; number_of_response:1; }","duration":"273.077509ms","start":"2026-06-06T17:11:05.508216Z","end":"2026-06-06T17:11:05.781293Z","steps":["trace[1896849933] 'process raft request'  (duration: 272.899415ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:11:05.781473Z","caller":"traceutil/trace.go:171","msg":"trace[1097628883] linearizableReadLoop","detail":"{readStateIndex:3991; appliedIndex:3989; }","duration":"127.191019ms","start":"2026-06-06T17:11:05.654257Z","end":"2026-06-06T17:11:05.781448Z","steps":["trace[1097628883] 'read index received'  (duration: 126.794449ms)","trace[1097628883] 'applied index is now lower than readState.Index'  (duration: 395.409µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:11:05.781827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.559737ms","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-06-06T17:11:05.781878Z","caller":"traceutil/trace.go:171","msg":"trace[839399867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3845; }","duration":"127.65961ms","start":"2026-06-06T17:11:05.654207Z","end":"2026-06-06T17:11:05.781867Z","steps":["trace[839399867] 'agreement among raft nodes before linearized reading'  (duration: 127.481205ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:11:05.781664Z","caller":"traceutil/trace.go:171","msg":"trace[1755416869] transaction","detail":"{read_only:false; response_revision:3845; number_of_response:1; }","duration":"176.04017ms","start":"2026-06-06T17:11:05.605569Z","end":"2026-06-06T17:11:05.781609Z","steps":["trace[1755416869] 'process raft request'  (duration: 175.678052ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:11:05.782066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.728412ms","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-06-06T17:11:05.782105Z","caller":"traceutil/trace.go:171","msg":"trace[264851245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3845; }","duration":"127.828714ms","start":"2026-06-06T17:11:05.654264Z","end":"2026-06-06T17:11:05.782093Z","steps":["trace[264851245] 'agreement among raft nodes before linearized reading'  (duration: 127.633909ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:12:28.658251Z","caller":"traceutil/trace.go:171","msg":"trace[1866565436] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"130.768371ms","start":"2026-06-06T17:12:28.527448Z","end":"2026-06-06T17:12:28.658216Z","steps":["trace[1866565436] 'process raft request'  (duration: 99.103416ms)","trace[1866565436] 'compare'  (duration: 31.503021ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:12:28.677751Z","caller":"traceutil/trace.go:171","msg":"trace[160931802] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4981; }","duration":"102.310743ms","start":"2026-06-06T17:12:28.575418Z","end":"2026-06-06T17:12:28.677728Z","steps":["trace[160931802] 'process raft request'  (duration: 102.128898ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:12:30.368441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.236824ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531438581 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4974 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-06T17:12:30.368607Z","caller":"traceutil/trace.go:171","msg":"trace[2036461339] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5224; }","duration":"169.443345ms","start":"2026-06-06T17:12:30.199144Z","end":"2026-06-06T17:12:30.368587Z","steps":["trace[2036461339] 'read index received'  (duration: 52.041488ms)","trace[2036461339] 'applied index is now lower than readState.Index'  (duration: 117.400357ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:12:30.368729Z","caller":"traceutil/trace.go:171","msg":"trace[328188671] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"180.007552ms","start":"2026-06-06T17:12:30.188709Z","end":"2026-06-06T17:12:30.368717Z","steps":["trace[328188671] 'process raft request'  (duration: 62.404599ms)","trace[328188671] 'compare'  (duration: 117.09795ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:12:30.368974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.820345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-06-06T17:12:30.369031Z","caller":"traceutil/trace.go:171","msg":"trace[855902746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5033; }","duration":"169.906657ms","start":"2026-06-06T17:12:30.199109Z","end":"2026-06-06T17:12:30.369016Z","steps":["trace[855902746] 'agreement among raft nodes before linearized reading'  (duration: 169.741793ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:12:30.369253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.690623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786872"}
{"level":"info","ts":"2026-06-06T17:12:30.369349Z","caller":"traceutil/trace.go:171","msg":"trace[1574041285] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5033; }","duration":"143.807345ms","start":"2026-06-06T17:12:30.225519Z","end":"2026-06-06T17:12:30.369327Z","steps":["trace[1574041285] 'agreement among raft nodes before linearized reading'  (duration: 143.274512ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:12:42.860862Z","caller":"traceutil/trace.go:171","msg":"trace[213817340] transaction","detail":"{read_only:false; response_revision:5252; number_of_response:1; }","duration":"111.714861ms","start":"2026-06-06T17:12:42.749117Z","end":"2026-06-06T17:12:42.860832Z","steps":["trace[213817340] 'process raft request'  (duration: 111.554107ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:12:51.404909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.09472ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531439462 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-6479589586-lwfm9\" mod_revision:5419 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-lwfm9\" value_size:8346 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-lwfm9\" > >>","response":"size:16"}
{"level":"info","ts":"2026-06-06T17:12:51.405153Z","caller":"traceutil/trace.go:171","msg":"trace[922262073] transaction","detail":"{read_only:false; response_revision:5420; number_of_response:1; }","duration":"110.50091ms","start":"2026-06-06T17:12:51.294635Z","end":"2026-06-06T17:12:51.405135Z","steps":["trace[922262073] 'compare'  (duration: 104.755312ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:13:02.522554Z","caller":"traceutil/trace.go:171","msg":"trace[647770495] transaction","detail":"{read_only:false; response_revision:5593; number_of_response:1; }","duration":"239.1641ms","start":"2026-06-06T17:13:02.283365Z","end":"2026-06-06T17:13:02.52253Z","steps":["trace[647770495] 'process raft request'  (duration: 238.966096ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:13:02.529934Z","caller":"traceutil/trace.go:171","msg":"trace[786022309] transaction","detail":"{read_only:false; response_revision:5594; number_of_response:1; }","duration":"245.142794ms","start":"2026-06-06T17:13:02.284771Z","end":"2026-06-06T17:13:02.529913Z","steps":["trace[786022309] 'process raft request'  (duration: 245.019231ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:14:03.65019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3009}
{"level":"info","ts":"2026-06-06T17:14:03.726077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3009,"took":"74.455569ms","hash":4033748584,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":31895552,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-06T17:14:03.726137Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4033748584,"revision":3009,"compact-revision":-1}
{"level":"info","ts":"2026-06-06T17:18:57.375424Z","caller":"traceutil/trace.go:171","msg":"trace[1664915958] linearizableReadLoop","detail":"{readStateIndex:8568; appliedIndex:8567; }","duration":"263.327698ms","start":"2026-06-06T17:18:57.112079Z","end":"2026-06-06T17:18:57.375407Z","steps":["trace[1664915958] 'read index received'  (duration: 263.231295ms)","trace[1664915958] 'applied index is now lower than readState.Index'  (duration: 95.423µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:18:57.375495Z","caller":"traceutil/trace.go:171","msg":"trace[236670015] transaction","detail":"{read_only:false; response_revision:8274; number_of_response:1; }","duration":"272.762465ms","start":"2026-06-06T17:18:57.1027Z","end":"2026-06-06T17:18:57.375463Z","steps":["trace[236670015] 'process raft request'  (duration: 272.57119ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:18:57.37557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.477292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-06-06T17:18:57.375592Z","caller":"traceutil/trace.go:171","msg":"trace[764908037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8274; }","duration":"263.541424ms","start":"2026-06-06T17:18:57.112045Z","end":"2026-06-06T17:18:57.375586Z","steps":["trace[764908037] 'agreement among raft nodes before linearized reading'  (duration: 263.446932ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:18:57.453081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.809645ms","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:5"}
{"level":"info","ts":"2026-06-06T17:18:57.453136Z","caller":"traceutil/trace.go:171","msg":"trace[1571374109] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:8275; }","duration":"314.939928ms","start":"2026-06-06T17:18:57.138186Z","end":"2026-06-06T17:18:57.453126Z","steps":["trace[1571374109] 'agreement among raft nodes before linearized reading'  (duration: 314.780724ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:18:57.453163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:18:57.138166Z","time spent":"314.989999ms","remote":"127.0.0.1:41270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"info","ts":"2026-06-06T17:18:57.45338Z","caller":"traceutil/trace.go:171","msg":"trace[892527481] transaction","detail":"{read_only:false; response_revision:8275; number_of_response:1; }","duration":"243.8596ms","start":"2026-06-06T17:18:57.209511Z","end":"2026-06-06T17:18:57.453371Z","steps":["trace[892527481] 'process raft request'  (duration: 243.361928ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:19:03.662753Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6112}
{"level":"info","ts":"2026-06-06T17:19:03.759049Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6112,"took":"94.624204ms","hash":3085109285,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":23441408,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-06-06T17:19:03.759166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3085109285,"revision":6112,"compact-revision":3009}
{"level":"info","ts":"2026-06-06T17:19:08.555293Z","caller":"traceutil/trace.go:171","msg":"trace[13325413] transaction","detail":"{read_only:false; response_revision:8334; number_of_response:1; }","duration":"167.804203ms","start":"2026-06-06T17:19:08.38746Z","end":"2026-06-06T17:19:08.555264Z","steps":["trace[13325413] 'process raft request'  (duration: 115.788763ms)","trace[13325413] 'compare'  (duration: 51.838995ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:19:10.115808Z","caller":"traceutil/trace.go:171","msg":"trace[79244107] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"201.661597ms","start":"2026-06-06T17:19:09.914122Z","end":"2026-06-06T17:19:10.115783Z","steps":["trace[79244107] 'process raft request'  (duration: 193.625764ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:19:37.212216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.303614ms","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-06-06T17:19:37.212315Z","caller":"traceutil/trace.go:171","msg":"trace[110189899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8541; }","duration":"359.461458ms","start":"2026-06-06T17:19:36.852831Z","end":"2026-06-06T17:19:37.212292Z","steps":["trace[110189899] 'range keys from in-memory index tree'  (duration: 359.11841ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:19:37.212356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:19:36.852808Z","time spent":"359.5403ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-06-06T17:19:37.212408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.483406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:19:37.212455Z","caller":"traceutil/trace.go:171","msg":"trace[1815935326] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:8541; }","duration":"309.554808ms","start":"2026-06-06T17:19:36.902884Z","end":"2026-06-06T17:19:37.212439Z","steps":["trace[1815935326] 'count revisions from in-memory index tree'  (duration: 309.365864ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:19:37.212483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:19:36.902869Z","time spent":"309.607589ms","remote":"127.0.0.1:37842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"warn","ts":"2026-06-06T17:19:37.212238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.456042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:19:37.21268Z","caller":"traceutil/trace.go:171","msg":"trace[264449055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8541; }","duration":"102.954784ms","start":"2026-06-06T17:19:37.109713Z","end":"2026-06-06T17:19:37.212668Z","steps":["trace[264449055] 'range keys from in-memory index tree'  (duration: 102.35837ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:19:49.39238Z","caller":"traceutil/trace.go:171","msg":"trace[1586228972] transaction","detail":"{read_only:false; response_revision:8648; number_of_response:1; }","duration":"102.616176ms","start":"2026-06-06T17:19:49.289739Z","end":"2026-06-06T17:19:49.392355Z","steps":["trace[1586228972] 'process raft request'  (duration: 102.462543ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:20:03.824203Z","caller":"traceutil/trace.go:171","msg":"trace[664506430] transaction","detail":"{read_only:false; response_revision:8764; number_of_response:1; }","duration":"105.290271ms","start":"2026-06-06T17:20:03.718894Z","end":"2026-06-06T17:20:03.824184Z","steps":["trace[664506430] 'process raft request'  (duration: 62.215195ms)","trace[664506430] 'compare'  (duration: 42.997604ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:20:11.755787Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000240c.wal"}
{"level":"warn","ts":"2026-06-06T17:21:05.401908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.334547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:21:05.40207Z","caller":"traceutil/trace.go:171","msg":"trace[2081163909] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:9397; }","duration":"201.89601ms","start":"2026-06-06T17:21:05.200149Z","end":"2026-06-06T17:21:05.402045Z","steps":["trace[2081163909] 'count revisions from in-memory index tree'  (duration: 201.151393ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:21:40.483462Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2d372260bb4c37a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-06T17:21:40.489675Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-06-06T17:21:40.489798Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-06-06T17:24:03.669724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8308}
{"level":"info","ts":"2026-06-06T17:24:03.749178Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8308,"took":"75.99232ms","hash":1441860157,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":26341376,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-06-06T17:24:03.749233Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1441860157,"revision":8308,"compact-revision":6112}
{"level":"info","ts":"2026-06-06T17:24:50.434962Z","caller":"traceutil/trace.go:171","msg":"trace[1878634438] transaction","detail":"{read_only:false; response_revision:11253; number_of_response:1; }","duration":"150.888765ms","start":"2026-06-06T17:24:50.284042Z","end":"2026-06-06T17:24:50.434931Z","steps":["trace[1878634438] 'process raft request'  (duration: 101.02123ms)","trace[1878634438] 'compare'  (duration: 49.609278ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:24:50.435224Z","caller":"traceutil/trace.go:171","msg":"trace[603939202] transaction","detail":"{read_only:false; response_revision:11254; number_of_response:1; }","duration":"149.369758ms","start":"2026-06-06T17:24:50.285819Z","end":"2026-06-06T17:24:50.435189Z","steps":["trace[603939202] 'process raft request'  (duration: 148.993759ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:29:03.681998Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10798}
{"level":"info","ts":"2026-06-06T17:29:03.769948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10798,"took":"85.50554ms","hash":2124882182,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":27521024,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-06-06T17:29:03.770004Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2124882182,"revision":10798,"compact-revision":8308}
{"level":"info","ts":"2026-06-06T17:30:38.01433Z","caller":"traceutil/trace.go:171","msg":"trace[1594946088] transaction","detail":"{read_only:false; response_revision:13629; number_of_response:1; }","duration":"130.769065ms","start":"2026-06-06T17:30:37.883534Z","end":"2026-06-06T17:30:38.014303Z","steps":["trace[1594946088] 'process raft request'  (duration: 130.589831ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:14.319876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.81792ms","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-06-06T17:31:14.319937Z","caller":"traceutil/trace.go:171","msg":"trace[1260291547] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13837; }","duration":"119.925762ms","start":"2026-06-06T17:31:14.2Z","end":"2026-06-06T17:31:14.319926Z","steps":["trace[1260291547] 'range keys from in-memory index tree'  (duration: 119.699348ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:31:14.444358Z","caller":"traceutil/trace.go:171","msg":"trace[203702636] transaction","detail":"{read_only:false; response_revision:13839; number_of_response:1; }","duration":"120.170699ms","start":"2026-06-06T17:31:14.324162Z","end":"2026-06-06T17:31:14.444333Z","steps":["trace[203702636] 'process raft request'  (duration: 106.853936ms)","trace[203702636] 'compare'  (duration: 13.139848ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:31:14.444682Z","caller":"traceutil/trace.go:171","msg":"trace[407088708] transaction","detail":"{read_only:false; response_revision:13840; number_of_response:1; }","duration":"120.410954ms","start":"2026-06-06T17:31:14.324243Z","end":"2026-06-06T17:31:14.444654Z","steps":["trace[407088708] 'process raft request'  (duration: 120.050326ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:15.248057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.485597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:31:15.248143Z","caller":"traceutil/trace.go:171","msg":"trace[106967969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13844; }","duration":"213.582999ms","start":"2026-06-06T17:31:15.034541Z","end":"2026-06-06T17:31:15.248124Z","steps":["trace[106967969] 'range keys from in-memory index tree'  (duration: 213.436555ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:15.248424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.447012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-06T17:31:15.248502Z","caller":"traceutil/trace.go:171","msg":"trace[858319784] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:13844; }","duration":"136.544425ms","start":"2026-06-06T17:31:15.11194Z","end":"2026-06-06T17:31:15.248484Z","steps":["trace[858319784] 'count revisions from in-memory index tree'  (duration: 136.372011ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:15.249024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.968295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-97cgg\" ","response":"range_response_count:1 size:12364"}
{"level":"info","ts":"2026-06-06T17:31:15.2491Z","caller":"traceutil/trace.go:171","msg":"trace[554697854] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-97cgg; range_end:; response_count:1; response_revision:13844; }","duration":"130.198321ms","start":"2026-06-06T17:31:15.118882Z","end":"2026-06-06T17:31:15.24908Z","steps":["trace[554697854] 'range keys from in-memory index tree'  (duration: 129.75699ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:16.872461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745185531462262,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-06-06T17:31:17.372776Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745185531462262,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-06-06T17:31:17.714195Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.488596447s","expected-duration":"1s"}
{"level":"warn","ts":"2026-06-06T17:31:17.714497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.225544Z","time spent":"1.488950615s","remote":"127.0.0.1:52726","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-06-06T17:31:17.717903Z","caller":"traceutil/trace.go:171","msg":"trace[311459510] linearizableReadLoop","detail":"{readStateIndex:14331; appliedIndex:14326; }","duration":"1.345463104s","start":"2026-06-06T17:31:16.37242Z","end":"2026-06-06T17:31:17.717883Z","steps":["trace[311459510] 'read index received'  (duration: 1.342008199s)","trace[311459510] 'applied index is now lower than readState.Index'  (duration: 3.453945ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:31:17.718148Z","caller":"traceutil/trace.go:171","msg":"trace[4084472] transaction","detail":"{read_only:false; response_revision:13849; number_of_response:1; }","duration":"1.48500785s","start":"2026-06-06T17:31:16.233128Z","end":"2026-06-06T17:31:17.718136Z","steps":["trace[4084472] 'process raft request'  (duration: 1.484499648s)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.718256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.233116Z","time spent":"1.485068071s","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12584,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/openvswitch-97cgg\" mod_revision:13846 > success:<request_put:<key:\"/registry/pods/openstack/openvswitch-97cgg\" value_size:12534 >> failure:<request_range:<key:\"/registry/pods/openstack/openvswitch-97cgg\" > >"}
{"level":"warn","ts":"2026-06-06T17:31:17.718615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270213782s","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-06-06T17:31:17.718658Z","caller":"traceutil/trace.go:171","msg":"trace[1385694423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13853; }","duration":"1.270291374s","start":"2026-06-06T17:31:16.448357Z","end":"2026-06-06T17:31:17.718648Z","steps":["trace[1385694423] 'agreement among raft nodes before linearized reading'  (duration: 1.27012657s)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.718682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.448351Z","time spent":"1.270325535s","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-06-06T17:31:17.718675Z","caller":"traceutil/trace.go:171","msg":"trace[163077544] transaction","detail":"{read_only:false; response_revision:13850; number_of_response:1; }","duration":"1.176536984s","start":"2026-06-06T17:31:16.542118Z","end":"2026-06-06T17:31:17.718655Z","steps":["trace[163077544] 'process raft request'  (duration: 1.175639983s)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.718765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.542103Z","time spent":"1.176613817s","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:13841 > 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-06-06T17:31:17.71894Z","caller":"traceutil/trace.go:171","msg":"trace[311594810] transaction","detail":"{read_only:false; response_revision:13851; number_of_response:1; }","duration":"836.721691ms","start":"2026-06-06T17:31:16.882207Z","end":"2026-06-06T17:31:17.718929Z","steps":["trace[311594810] 'process raft request'  (duration: 835.599134ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.71897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.123368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-06T17:31:17.719001Z","caller":"traceutil/trace.go:171","msg":"trace[1675400241] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:13853; }","duration":"263.177679ms","start":"2026-06-06T17:31:17.455814Z","end":"2026-06-06T17:31:17.718992Z","steps":["trace[1675400241] 'agreement among raft nodes before linearized reading'  (duration: 263.124398ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.71901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.882198Z","time spent":"836.778232ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:13844 > 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-06-06T17:31:17.719195Z","caller":"traceutil/trace.go:171","msg":"trace[1038097800] transaction","detail":"{read_only:false; response_revision:13852; number_of_response:1; }","duration":"836.861764ms","start":"2026-06-06T17:31:16.882323Z","end":"2026-06-06T17:31:17.719184Z","steps":["trace[1038097800] 'process raft request'  (duration: 835.520962ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.344401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cm679\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-06-06T17:31:17.719244Z","caller":"traceutil/trace.go:171","msg":"trace[136352174] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cm679; range_end:; response_count:1; response_revision:13853; }","duration":"429.365921ms","start":"2026-06-06T17:31:17.289872Z","end":"2026-06-06T17:31:17.719238Z","steps":["trace[136352174] 'agreement among raft nodes before linearized reading'  (duration: 429.290769ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.882301Z","time spent":"836.917365ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:13785 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-06-06T17:31:17.719262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:17.289807Z","time spent":"429.450554ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-cm679\" "}
{"level":"warn","ts":"2026-06-06T17:31:17.719386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.735784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-06-06T17:31:17.71941Z","caller":"traceutil/trace.go:171","msg":"trace[352814405] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13853; }","duration":"435.787536ms","start":"2026-06-06T17:31:17.283616Z","end":"2026-06-06T17:31:17.719403Z","steps":["trace[352814405] 'agreement among raft nodes before linearized reading'  (duration: 435.728425ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:17.2836Z","time spent":"435.822857ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-06-06T17:31:17.719492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270419416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-06-06T17:31:17.719533Z","caller":"traceutil/trace.go:171","msg":"trace[157552697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13853; }","duration":"1.270467058s","start":"2026-06-06T17:31:16.449052Z","end":"2026-06-06T17:31:17.719519Z","steps":["trace[157552697] 'agreement among raft nodes before linearized reading'  (duration: 1.270353555s)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.449047Z","time spent":"1.270507889s","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-06-06T17:31:17.719561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.451618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-06-06T17:31:17.719606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.85629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-06T17:31:17.719635Z","caller":"traceutil/trace.go:171","msg":"trace[863491299] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:13853; }","duration":"502.8894ms","start":"2026-06-06T17:31:17.216739Z","end":"2026-06-06T17:31:17.719628Z","steps":["trace[863491299] 'agreement among raft nodes before linearized reading'  (duration: 502.827139ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:17.21672Z","time spent":"502.933052ms","remote":"127.0.0.1:53134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":13,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-06-06T17:31:17.7197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.590071ms","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-06-06T17:31:17.719636Z","caller":"traceutil/trace.go:171","msg":"trace[35681959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13853; }","duration":"685.556482ms","start":"2026-06-06T17:31:17.03406Z","end":"2026-06-06T17:31:17.719616Z","steps":["trace[35681959] 'agreement among raft nodes before linearized reading'  (duration: 685.430949ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:31:17.719733Z","caller":"traceutil/trace.go:171","msg":"trace[240559440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13853; }","duration":"837.635543ms","start":"2026-06-06T17:31:16.882088Z","end":"2026-06-06T17:31:17.719724Z","steps":["trace[240559440] 'agreement among raft nodes before linearized reading'  (duration: 837.549311ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:17.034053Z","time spent":"685.685455ms","remote":"127.0.0.1:52658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-06-06T17:31:17.719761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.882081Z","time spent":"837.673693ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-06-06T17:31:17.719804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.130004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:138"}
{"level":"warn","ts":"2026-06-06T17:31:17.71986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347438971s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-06-06T17:31:17.719935Z","caller":"traceutil/trace.go:171","msg":"trace[1062401865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13853; }","duration":"1.347541672s","start":"2026-06-06T17:31:16.372383Z","end":"2026-06-06T17:31:17.719925Z","steps":["trace[1062401865] 'agreement among raft nodes before linearized reading'  (duration: 1.346967489s)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.719974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.372367Z","time spent":"1.347600964s","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-06-06T17:31:17.719871Z","caller":"traceutil/trace.go:171","msg":"trace[723720975] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:13853; }","duration":"838.219466ms","start":"2026-06-06T17:31:16.881629Z","end":"2026-06-06T17:31:17.719849Z","steps":["trace[723720975] 'agreement among raft nodes before linearized reading'  (duration: 838.072442ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:31:17.72005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:31:16.881612Z","time spent":"838.431271ms","remote":"127.0.0.1:52692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/199.204.45.162\" "}
{"level":"info","ts":"2026-06-06T17:34:03.698361Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12911}
{"level":"info","ts":"2026-06-06T17:34:03.788701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12911,"took":"88.299695ms","hash":39406843,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":30703616,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-06T17:34:03.788757Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":39406843,"revision":12911,"compact-revision":10798}
{"level":"info","ts":"2026-06-06T17:38:45.825662Z","caller":"traceutil/trace.go:171","msg":"trace[360589204] transaction","detail":"{read_only:false; response_revision:17517; number_of_response:1; }","duration":"103.37396ms","start":"2026-06-06T17:38:45.722259Z","end":"2026-06-06T17:38:45.825633Z","steps":["trace[360589204] 'process raft request'  (duration: 73.15977ms)","trace[360589204] 'compare'  (duration: 29.965094ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:38:46.066231Z","caller":"traceutil/trace.go:171","msg":"trace[975300480] transaction","detail":"{read_only:false; response_revision:17519; number_of_response:1; }","duration":"108.968637ms","start":"2026-06-06T17:38:45.957241Z","end":"2026-06-06T17:38:46.06621Z","steps":["trace[975300480] 'process raft request'  (duration: 108.671769ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:38:46.880305Z","caller":"traceutil/trace.go:171","msg":"trace[1886349087] transaction","detail":"{read_only:false; response_revision:17523; number_of_response:1; }","duration":"118.438084ms","start":"2026-06-06T17:38:46.761846Z","end":"2026-06-06T17:38:46.880284Z","steps":["trace[1886349087] 'process raft request'  (duration: 118.293871ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:38:47.096793Z","caller":"traceutil/trace.go:171","msg":"trace[1325826862] linearizableReadLoop","detail":"{readStateIndex:18120; appliedIndex:18119; }","duration":"144.076416ms","start":"2026-06-06T17:38:46.952694Z","end":"2026-06-06T17:38:47.096771Z","steps":["trace[1325826862] 'read index received'  (duration: 143.962333ms)","trace[1325826862] 'applied index is now lower than readState.Index'  (duration: 112.973µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:38:47.096971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.27202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-gzglv\" ","response":"range_response_count:1 size:9797"}
{"level":"info","ts":"2026-06-06T17:38:47.097032Z","caller":"traceutil/trace.go:171","msg":"trace[653484208] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-gzglv; range_end:; response_count:1; response_revision:17523; }","duration":"144.379973ms","start":"2026-06-06T17:38:46.952637Z","end":"2026-06-06T17:38:47.097017Z","steps":["trace[653484208] 'agreement among raft nodes before linearized reading'  (duration: 144.207398ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:39:03.706194Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15354}
{"level":"info","ts":"2026-06-06T17:39:03.798555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15354,"took":"89.841124ms","hash":3700940372,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":32083968,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-06T17:39:03.798626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3700940372,"revision":15354,"compact-revision":12911}
{"level":"warn","ts":"2026-06-06T17:40:44.300952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.948584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:40:44.301025Z","caller":"traceutil/trace.go:171","msg":"trace[1342191130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18666; }","duration":"267.069778ms","start":"2026-06-06T17:40:44.033938Z","end":"2026-06-06T17:40:44.301008Z","steps":["trace[1342191130] 'range keys from in-memory index tree'  (duration: 266.868133ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:40:44.303264Z","caller":"traceutil/trace.go:171","msg":"trace[1821555403] transaction","detail":"{read_only:false; response_revision:18667; number_of_response:1; }","duration":"229.03718ms","start":"2026-06-06T17:40:44.074208Z","end":"2026-06-06T17:40:44.303245Z","steps":["trace[1821555403] 'process raft request'  (duration: 228.853616ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:40:44.303775Z","caller":"traceutil/trace.go:171","msg":"trace[382372588] transaction","detail":"{read_only:false; response_revision:18668; number_of_response:1; }","duration":"218.935556ms","start":"2026-06-06T17:40:44.084815Z","end":"2026-06-06T17:40:44.303751Z","steps":["trace[382372588] 'process raft request'  (duration: 218.736721ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:42:25.164966Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2d372260bb4c37a","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-06T17:42:25.170879Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-06-06T17:42:25.171041Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-06-06T17:43:31.584679Z","caller":"traceutil/trace.go:171","msg":"trace[1676396309] linearizableReadLoop","detail":"{readStateIndex:20555; appliedIndex:20554; }","duration":"134.596509ms","start":"2026-06-06T17:43:31.450059Z","end":"2026-06-06T17:43:31.584655Z","steps":["trace[1676396309] 'read index received'  (duration: 134.390265ms)","trace[1676396309] 'applied index is now lower than readState.Index'  (duration: 205.644µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:43:31.584728Z","caller":"traceutil/trace.go:171","msg":"trace[155535814] transaction","detail":"{read_only:false; response_revision:19883; number_of_response:1; }","duration":"172.811842ms","start":"2026-06-06T17:43:31.411887Z","end":"2026-06-06T17:43:31.584699Z","steps":["trace[155535814] 'process raft request'  (duration: 172.619608ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:43:31.584832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.781364ms","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-06-06T17:43:31.584866Z","caller":"traceutil/trace.go:171","msg":"trace[756326702] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:19883; }","duration":"134.881306ms","start":"2026-06-06T17:43:31.44997Z","end":"2026-06-06T17:43:31.584852Z","steps":["trace[756326702] 'agreement among raft nodes before linearized reading'  (duration: 134.804364ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:43:31.585997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.84687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-06-06T17:43:31.58604Z","caller":"traceutil/trace.go:171","msg":"trace[1397494260] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:19883; }","duration":"118.937962ms","start":"2026-06-06T17:43:31.467093Z","end":"2026-06-06T17:43:31.586031Z","steps":["trace[1397494260] 'agreement among raft nodes before linearized reading'  (duration: 117.783844ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:44:03.713939Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17765}
{"level":"info","ts":"2026-06-06T17:44:03.814236Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17765,"took":"95.470555ms","hash":830615377,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":33816576,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-06-06T17:44:03.814292Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":830615377,"revision":17765,"compact-revision":15354}
{"level":"info","ts":"2026-06-06T17:44:27.613753Z","caller":"traceutil/trace.go:171","msg":"trace[1319910720] linearizableReadLoop","detail":"{readStateIndex:20860; appliedIndex:20859; }","duration":"169.055052ms","start":"2026-06-06T17:44:27.444673Z","end":"2026-06-06T17:44:27.613728Z","steps":["trace[1319910720] 'read index received'  (duration: 168.889338ms)","trace[1319910720] 'applied index is now lower than readState.Index'  (duration: 164.744µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:44:27.613858Z","caller":"traceutil/trace.go:171","msg":"trace[358135767] transaction","detail":"{read_only:false; response_revision:20174; number_of_response:1; }","duration":"201.948216ms","start":"2026-06-06T17:44:27.411859Z","end":"2026-06-06T17:44:27.613807Z","steps":["trace[358135767] 'process raft request'  (duration: 201.69496ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:44:27.613983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.287058ms","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-06-06T17:44:27.614033Z","caller":"traceutil/trace.go:171","msg":"trace[1236476719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20174; }","duration":"169.39276ms","start":"2026-06-06T17:44:27.444628Z","end":"2026-06-06T17:44:27.614021Z","steps":["trace[1236476719] 'agreement among raft nodes before linearized reading'  (duration: 169.206116ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:44:27.724586Z","caller":"traceutil/trace.go:171","msg":"trace[2026291015] transaction","detail":"{read_only:false; response_revision:20175; number_of_response:1; }","duration":"106.541922ms","start":"2026-06-06T17:44:27.618017Z","end":"2026-06-06T17:44:27.724559Z","steps":["trace[2026291015] 'process raft request'  (duration: 89.658355ms)","trace[2026291015] 'compare'  (duration: 16.541739ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:44:28.085733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.809539ms","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-06-06T17:44:28.085803Z","caller":"traceutil/trace.go:171","msg":"trace[1699684008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20175; }","duration":"159.921881ms","start":"2026-06-06T17:44:27.925866Z","end":"2026-06-06T17:44:28.085788Z","steps":["trace[1699684008] 'range keys from in-memory index tree'  (duration: 159.657815ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:44:28.08578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.678718ms","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-06-06T17:44:28.085862Z","caller":"traceutil/trace.go:171","msg":"trace[135457678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20175; }","duration":"145.80723ms","start":"2026-06-06T17:44:27.940034Z","end":"2026-06-06T17:44:28.085841Z","steps":["trace[135457678] 'range keys from in-memory index tree'  (duration: 145.515153ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:44:28.086181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.150602ms","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-06-06T17:44:28.086272Z","caller":"traceutil/trace.go:171","msg":"trace[857033364] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20175; }","duration":"159.274805ms","start":"2026-06-06T17:44:27.926969Z","end":"2026-06-06T17:44:28.086244Z","steps":["trace[857033364] 'range keys from in-memory index tree'  (duration: 158.962348ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:44:28.085637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.919888ms","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-06-06T17:44:28.087602Z","caller":"traceutil/trace.go:171","msg":"trace[880357642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20175; }","duration":"170.089966ms","start":"2026-06-06T17:44:27.916644Z","end":"2026-06-06T17:44:28.086734Z","steps":["trace[880357642] 'range keys from in-memory index tree'  (duration: 168.747024ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:44:28.820445Z","caller":"traceutil/trace.go:171","msg":"trace[532012966] transaction","detail":"{read_only:false; response_revision:20180; number_of_response:1; }","duration":"224.141112ms","start":"2026-06-06T17:44:28.59628Z","end":"2026-06-06T17:44:28.820421Z","steps":["trace[532012966] 'process raft request'  (duration: 223.991258ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:44:28.848089Z","caller":"traceutil/trace.go:171","msg":"trace[926989135] transaction","detail":"{read_only:false; response_revision:20181; number_of_response:1; }","duration":"251.466951ms","start":"2026-06-06T17:44:28.596598Z","end":"2026-06-06T17:44:28.848065Z","steps":["trace[926989135] 'process raft request'  (duration: 251.299328ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:44:29.140095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.266851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:44:29.140274Z","caller":"traceutil/trace.go:171","msg":"trace[1823931333] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:20182; }","duration":"110.510208ms","start":"2026-06-06T17:44:29.029734Z","end":"2026-06-06T17:44:29.140244Z","steps":["trace[1823931333] 'count revisions from in-memory index tree'  (duration: 110.135929ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:44:29.140168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.645586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:44:29.140474Z","caller":"traceutil/trace.go:171","msg":"trace[1372964264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20182; }","duration":"104.984455ms","start":"2026-06-06T17:44:29.035458Z","end":"2026-06-06T17:44:29.140443Z","steps":["trace[1372964264] 'range keys from in-memory index tree'  (duration: 104.563334ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:48:23.23128Z","caller":"traceutil/trace.go:171","msg":"trace[417722256] linearizableReadLoop","detail":"{readStateIndex:23376; appliedIndex:23375; }","duration":"267.848606ms","start":"2026-06-06T17:48:22.963409Z","end":"2026-06-06T17:48:23.231257Z","steps":["trace[417722256] 'read index received'  (duration: 267.61395ms)","trace[417722256] 'applied index is now lower than readState.Index'  (duration: 233.736µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:48:23.231388Z","caller":"traceutil/trace.go:171","msg":"trace[996246378] transaction","detail":"{read_only:false; response_revision:22616; number_of_response:1; }","duration":"310.074485ms","start":"2026-06-06T17:48:22.921245Z","end":"2026-06-06T17:48:23.23132Z","steps":["trace[996246378] 'process raft request'  (duration: 309.85398ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:48:23.231478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.058651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-06T17:48:23.231512Z","caller":"traceutil/trace.go:171","msg":"trace[988395716] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:22616; }","duration":"268.150904ms","start":"2026-06-06T17:48:22.963349Z","end":"2026-06-06T17:48:23.231499Z","steps":["trace[988395716] 'agreement among raft nodes before linearized reading'  (duration: 268.039511ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:48:23.231609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:48:22.921224Z","time spent":"310.281521ms","remote":"127.0.0.1:52726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":973,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager-7b7d6b5594-mwx85.18b68f2799d0588a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager-7b7d6b5594-mwx85.18b68f2799d0588a\" value_size:833 lease:4862373148676712738 >> failure:<>"}
{"level":"info","ts":"2026-06-06T17:49:03.722695Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20052}
{"level":"info","ts":"2026-06-06T17:49:03.832673Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20052,"took":"106.04282ms","hash":4121585613,"current-db-size-bytes":57413632,"current-db-size":"57 MB","current-db-size-in-use-bytes":40718336,"current-db-size-in-use":"41 MB"}
{"level":"info","ts":"2026-06-06T17:49:03.832771Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4121585613,"revision":20052,"compact-revision":17765}
{"level":"info","ts":"2026-06-06T17:51:59.683188Z","caller":"traceutil/trace.go:171","msg":"trace[85639955] transaction","detail":"{read_only:false; response_revision:24814; number_of_response:1; }","duration":"131.415523ms","start":"2026-06-06T17:51:59.551751Z","end":"2026-06-06T17:51:59.683167Z","steps":["trace[85639955] 'process raft request'  (duration: 131.231159ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:51:59.811165Z","caller":"traceutil/trace.go:171","msg":"trace[1172099745] transaction","detail":"{read_only:false; response_revision:24815; number_of_response:1; }","duration":"234.297177ms","start":"2026-06-06T17:51:59.57684Z","end":"2026-06-06T17:51:59.811138Z","steps":["trace[1172099745] 'process raft request'  (duration: 222.155234ms)","trace[1172099745] 'compare'  (duration: 11.972709ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:00.071848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.751503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:00.072008Z","caller":"traceutil/trace.go:171","msg":"trace[990135911] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24815; }","duration":"110.969199ms","start":"2026-06-06T17:51:59.961017Z","end":"2026-06-06T17:52:00.071986Z","steps":["trace[990135911] 'count revisions from in-memory index tree'  (duration: 110.58215ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.437091Z","caller":"traceutil/trace.go:171","msg":"trace[2076774371] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"331.823643ms","start":"2026-06-06T17:52:04.105245Z","end":"2026-06-06T17:52:04.437069Z","steps":["trace[2076774371] 'process raft request'  (duration: 331.661759ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:04.437201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:04.105228Z","time spent":"331.916515ms","remote":"127.0.0.1:52940","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:24832 > 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-06-06T17:52:04.496079Z","caller":"traceutil/trace.go:171","msg":"trace[1892876818] linearizableReadLoop","detail":"{readStateIndex:25671; appliedIndex:25669; }","duration":"122.955639ms","start":"2026-06-06T17:52:04.3731Z","end":"2026-06-06T17:52:04.496056Z","steps":["trace[1892876818] 'read index received'  (duration: 63.927574ms)","trace[1892876818] 'applied index is now lower than readState.Index'  (duration: 59.027025ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:04.49619Z","caller":"traceutil/trace.go:171","msg":"trace[343191188] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"227.680979ms","start":"2026-06-06T17:52:04.268494Z","end":"2026-06-06T17:52:04.496175Z","steps":["trace[343191188] 'process raft request'  (duration: 227.426213ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:04.496409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.302768ms","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-06-06T17:52:04.496473Z","caller":"traceutil/trace.go:171","msg":"trace[1077502336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24853; }","duration":"123.415151ms","start":"2026-06-06T17:52:04.373043Z","end":"2026-06-06T17:52:04.496458Z","steps":["trace[1077502336] 'agreement among raft nodes before linearized reading'  (duration: 123.216226ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:04.775814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.476983ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531495834 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24839 > 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-06-06T17:52:04.775962Z","caller":"traceutil/trace.go:171","msg":"trace[1654064374] linearizableReadLoop","detail":"{readStateIndex:25673; appliedIndex:25671; }","duration":"279.806897ms","start":"2026-06-06T17:52:04.496145Z","end":"2026-06-06T17:52:04.775952Z","steps":["trace[1654064374] 'read index received'  (duration: 139.14814ms)","trace[1654064374] 'applied index is now lower than readState.Index'  (duration: 140.658107ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:04.776002Z","caller":"traceutil/trace.go:171","msg":"trace[1396348362] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"312.22375ms","start":"2026-06-06T17:52:04.463769Z","end":"2026-06-06T17:52:04.775993Z","steps":["trace[1396348362] 'process raft request'  (duration: 312.114007ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.776018Z","caller":"traceutil/trace.go:171","msg":"trace[1719083234] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"321.739869ms","start":"2026-06-06T17:52:04.454273Z","end":"2026-06-06T17:52:04.776013Z","steps":["trace[1719083234] 'process raft request'  (duration: 181.0078ms)","trace[1719083234] 'compare'  (duration: 140.191836ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:04.776049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:04.454253Z","time spent":"321.77926ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24839 > 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-06-06T17:52:04.776052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:04.463759Z","time spent":"312.267951ms","remote":"127.0.0.1:52940","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:24840 > 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-06-06T17:52:04.776126Z","caller":"traceutil/trace.go:171","msg":"trace[749498036] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"275.103433ms","start":"2026-06-06T17:52:04.500995Z","end":"2026-06-06T17:52:04.776098Z","steps":["trace[749498036] 'process raft request'  (duration: 274.938339ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:04.776184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.556197ms","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-06-06T17:52:04.776262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.30845ms","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-06-06T17:52:04.776292Z","caller":"traceutil/trace.go:171","msg":"trace[1451060727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24856; }","duration":"377.68961ms","start":"2026-06-06T17:52:04.398584Z","end":"2026-06-06T17:52:04.776273Z","steps":["trace[1451060727] 'agreement among raft nodes before linearized reading'  (duration: 377.394233ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.776315Z","caller":"traceutil/trace.go:171","msg":"trace[1844041247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24856; }","duration":"379.356701ms","start":"2026-06-06T17:52:04.396942Z","end":"2026-06-06T17:52:04.776299Z","steps":["trace[1844041247] 'agreement among raft nodes before linearized reading'  (duration: 379.058704ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:04.776349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:04.396874Z","time spent":"379.466893ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-06-06T17:52:04.776356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:04.398563Z","time spent":"377.772962ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-06-06T17:52:04.77626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.663311ms","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-06-06T17:52:04.776427Z","caller":"traceutil/trace.go:171","msg":"trace[878933671] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24856; }","duration":"382.885496ms","start":"2026-06-06T17:52:04.393533Z","end":"2026-06-06T17:52:04.776419Z","steps":["trace[878933671] 'agreement among raft nodes before linearized reading'  (duration: 382.483806ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:04.776452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:04.393389Z","time spent":"383.05661ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-06-06T17:52:04.846873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.119295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"}
{"level":"info","ts":"2026-06-06T17:52:04.846889Z","caller":"traceutil/trace.go:171","msg":"trace[282516610] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"157.895773ms","start":"2026-06-06T17:52:04.68895Z","end":"2026-06-06T17:52:04.846846Z","steps":["trace[282516610] 'process raft request'  (duration: 157.644577ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.846957Z","caller":"traceutil/trace.go:171","msg":"trace[1486043298] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:24857; }","duration":"191.251628ms","start":"2026-06-06T17:52:04.655685Z","end":"2026-06-06T17:52:04.846936Z","steps":["trace[1486043298] 'agreement among raft nodes before linearized reading'  (duration: 191.039863ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.970476Z","caller":"traceutil/trace.go:171","msg":"trace[583667317] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"190.281505ms","start":"2026-06-06T17:52:04.780167Z","end":"2026-06-06T17:52:04.970448Z","steps":["trace[583667317] 'process raft request'  (duration: 146.824115ms)","trace[583667317] 'compare'  (duration: 43.259925ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:04.9708Z","caller":"traceutil/trace.go:171","msg":"trace[1241338392] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"190.578062ms","start":"2026-06-06T17:52:04.780191Z","end":"2026-06-06T17:52:04.970769Z","steps":["trace[1241338392] 'process raft request'  (duration: 190.207183ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.970835Z","caller":"traceutil/trace.go:171","msg":"trace[221437319] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"188.00697ms","start":"2026-06-06T17:52:04.782811Z","end":"2026-06-06T17:52:04.970818Z","steps":["trace[221437319] 'process raft request'  (duration: 187.816525ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:04.970852Z","caller":"traceutil/trace.go:171","msg":"trace[111469251] linearizableReadLoop","detail":"{readStateIndex:25678; appliedIndex:25675; }","duration":"121.123954ms","start":"2026-06-06T17:52:04.849706Z","end":"2026-06-06T17:52:04.97083Z","steps":["trace[111469251] 'read index received'  (duration: 77.252085ms)","trace[111469251] 'applied index is now lower than readState.Index'  (duration: 43.869769ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:04.97103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.311948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-13e8e19f-ed50-43a8-9e92-6bdfc9593d61\" ","response":"range_response_count:1 size:1316"}
{"level":"info","ts":"2026-06-06T17:52:04.971058Z","caller":"traceutil/trace.go:171","msg":"trace[421393886] range","detail":"{range_begin:/registry/persistentvolumes/pvc-13e8e19f-ed50-43a8-9e92-6bdfc9593d61; range_end:; response_count:1; response_revision:24862; }","duration":"121.35334ms","start":"2026-06-06T17:52:04.849696Z","end":"2026-06-06T17:52:04.97105Z","steps":["trace[421393886] 'agreement among raft nodes before linearized reading'  (duration: 121.199547ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:06.137929Z","caller":"traceutil/trace.go:171","msg":"trace[1106473602] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"295.885056ms","start":"2026-06-06T17:52:05.842025Z","end":"2026-06-06T17:52:06.13791Z","steps":["trace[1106473602] 'process raft request'  (duration: 295.749613ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:06.383702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.20043ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531495859 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24850 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:52:06.383911Z","caller":"traceutil/trace.go:171","msg":"trace[1232225839] transaction","detail":"{read_only:false; response_revision:24865; number_of_response:1; }","duration":"192.158381ms","start":"2026-06-06T17:52:06.191739Z","end":"2026-06-06T17:52:06.383897Z","steps":["trace[1232225839] 'process raft request'  (duration: 192.066419ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:06.384002Z","caller":"traceutil/trace.go:171","msg":"trace[1371878383] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"277.01454ms","start":"2026-06-06T17:52:06.106954Z","end":"2026-06-06T17:52:06.383969Z","steps":["trace[1371878383] 'process raft request'  (duration: 147.444ms)","trace[1371878383] 'compare'  (duration: 128.904943ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:06.618214Z","caller":"traceutil/trace.go:171","msg":"trace[1386417509] transaction","detail":"{read_only:false; response_revision:24867; number_of_response:1; }","duration":"117.333304ms","start":"2026-06-06T17:52:06.50085Z","end":"2026-06-06T17:52:06.618183Z","steps":["trace[1386417509] 'process raft request'  (duration: 115.369086ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:06.983473Z","caller":"traceutil/trace.go:171","msg":"trace[1465001931] transaction","detail":"{read_only:false; response_revision:24868; number_of_response:1; }","duration":"202.120722ms","start":"2026-06-06T17:52:06.781338Z","end":"2026-06-06T17:52:06.983458Z","steps":["trace[1465001931] 'process raft request'  (duration: 202.013549ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:06.996831Z","caller":"traceutil/trace.go:171","msg":"trace[84672458] transaction","detail":"{read_only:false; response_revision:24870; number_of_response:1; }","duration":"150.261748ms","start":"2026-06-06T17:52:06.846549Z","end":"2026-06-06T17:52:06.996811Z","steps":["trace[84672458] 'process raft request'  (duration: 150.185476ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:06.996982Z","caller":"traceutil/trace.go:171","msg":"trace[984770013] transaction","detail":"{read_only:false; response_revision:24869; number_of_response:1; }","duration":"215.483694ms","start":"2026-06-06T17:52:06.781464Z","end":"2026-06-06T17:52:06.996948Z","steps":["trace[984770013] 'process raft request'  (duration: 215.132406ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:06.997183Z","caller":"traceutil/trace.go:171","msg":"trace[1403911339] linearizableReadLoop","detail":"{readStateIndex:25687; appliedIndex:25685; }","duration":"183.785847ms","start":"2026-06-06T17:52:06.813371Z","end":"2026-06-06T17:52:06.997157Z","steps":["trace[1403911339] 'read index received'  (duration: 170.016245ms)","trace[1403911339] 'applied index is now lower than readState.Index'  (duration: 13.767372ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:06.997322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.937572ms","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-06-06T17:52:06.997374Z","caller":"traceutil/trace.go:171","msg":"trace[1809144808] 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:24872; }","duration":"184.040075ms","start":"2026-06-06T17:52:06.813325Z","end":"2026-06-06T17:52:06.997365Z","steps":["trace[1809144808] 'agreement among raft nodes before linearized reading'  (duration: 183.940443ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:06.997392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.256699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:06.997445Z","caller":"traceutil/trace.go:171","msg":"trace[579133818] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24872; }","duration":"157.381722ms","start":"2026-06-06T17:52:06.840052Z","end":"2026-06-06T17:52:06.997434Z","steps":["trace[579133818] 'agreement among raft nodes before linearized reading'  (duration: 157.274099ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:07.164222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.637651ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531495873 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:437a9e9de44605c0>","response":"size:40"}
{"level":"info","ts":"2026-06-06T17:52:07.437213Z","caller":"traceutil/trace.go:171","msg":"trace[804557110] linearizableReadLoop","detail":"{readStateIndex:25694; appliedIndex:25690; }","duration":"434.690958ms","start":"2026-06-06T17:52:07.0025Z","end":"2026-06-06T17:52:07.437191Z","steps":["trace[804557110] 'read index received'  (duration: 44.056274ms)","trace[804557110] 'applied index is now lower than readState.Index'  (duration: 390.633674ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:07.437262Z","caller":"traceutil/trace.go:171","msg":"trace[199419574] transaction","detail":"{read_only:false; response_revision:24874; number_of_response:1; }","duration":"435.664141ms","start":"2026-06-06T17:52:07.001572Z","end":"2026-06-06T17:52:07.437236Z","steps":["trace[199419574] 'process raft request'  (duration: 435.470405ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:07.437316Z","caller":"traceutil/trace.go:171","msg":"trace[83580695] transaction","detail":"{read_only:false; response_revision:24875; number_of_response:1; }","duration":"435.21949ms","start":"2026-06-06T17:52:07.002087Z","end":"2026-06-06T17:52:07.437306Z","steps":["trace[83580695] 'process raft request'  (duration: 435.061227ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:07.437401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:07.002072Z","time spent":"435.268041ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24859 > 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-06-06T17:52:07.437402Z","caller":"traceutil/trace.go:171","msg":"trace[1527073716] transaction","detail":"{read_only:false; response_revision:24873; number_of_response:1; }","duration":"435.971118ms","start":"2026-06-06T17:52:07.001398Z","end":"2026-06-06T17:52:07.437369Z","steps":["trace[1527073716] 'process raft request'  (duration: 385.732715ms)","trace[1527073716] 'compare'  (duration: 49.693259ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:07.437569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:07.001378Z","time spent":"436.097871ms","remote":"127.0.0.1:52940","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:24858 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-06-06T17:52:07.437606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.067716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:07.437686Z","caller":"traceutil/trace.go:171","msg":"trace[1200222798] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24875; }","duration":"435.172049ms","start":"2026-06-06T17:52:07.002495Z","end":"2026-06-06T17:52:07.437667Z","steps":["trace[1200222798] 'agreement among raft nodes before linearized reading'  (duration: 434.995775ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:07.437729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:07.002473Z","time spent":"435.247221ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-06-06T17:52:07.442299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.633293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:07.442377Z","caller":"traceutil/trace.go:171","msg":"trace[599569277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24877; }","duration":"407.749225ms","start":"2026-06-06T17:52:07.034611Z","end":"2026-06-06T17:52:07.44236Z","steps":["trace[599569277] 'agreement among raft nodes before linearized reading'  (duration: 407.603992ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:07.442417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:07.034592Z","time spent":"407.816758ms","remote":"127.0.0.1:52666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-06-06T17:52:07.442604Z","caller":"traceutil/trace.go:171","msg":"trace[1660339946] transaction","detail":"{read_only:false; response_revision:24876; number_of_response:1; }","duration":"277.158052ms","start":"2026-06-06T17:52:07.16542Z","end":"2026-06-06T17:52:07.442578Z","steps":["trace[1660339946] 'process raft request'  (duration: 276.596798ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:07.442906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.515568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274822"}
{"level":"info","ts":"2026-06-06T17:52:07.442931Z","caller":"traceutil/trace.go:171","msg":"trace[508418941] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:24877; }","duration":"134.5721ms","start":"2026-06-06T17:52:07.308351Z","end":"2026-06-06T17:52:07.442923Z","steps":["trace[508418941] 'agreement among raft nodes before linearized reading'  (duration: 134.262942ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:07.437421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:07.001557Z","time spent":"435.760913ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24860 > 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-06-06T17:52:08.259855Z","caller":"traceutil/trace.go:171","msg":"trace[1254251921] transaction","detail":"{read_only:false; response_revision:24878; number_of_response:1; }","duration":"116.165355ms","start":"2026-06-06T17:52:08.143669Z","end":"2026-06-06T17:52:08.259834Z","steps":["trace[1254251921] 'process raft request'  (duration: 116.013291ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:08.794377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.835813ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531495890 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24864 > 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-06-06T17:52:08.794786Z","caller":"traceutil/trace.go:171","msg":"trace[1373498418] transaction","detail":"{read_only:false; response_revision:24882; number_of_response:1; }","duration":"170.817225ms","start":"2026-06-06T17:52:08.623946Z","end":"2026-06-06T17:52:08.794763Z","steps":["trace[1373498418] 'process raft request'  (duration: 170.749533ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:08.794847Z","caller":"traceutil/trace.go:171","msg":"trace[1045044123] transaction","detail":"{read_only:false; response_revision:24880; number_of_response:1; }","duration":"404.283482ms","start":"2026-06-06T17:52:08.390535Z","end":"2026-06-06T17:52:08.794818Z","steps":["trace[1045044123] 'process raft request'  (duration: 252.923748ms)","trace[1045044123] 'compare'  (duration: 150.700089ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:08.794981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:08.39051Z","time spent":"404.401315ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24864 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-06-06T17:52:08.794974Z","caller":"traceutil/trace.go:171","msg":"trace[703197853] linearizableReadLoop","detail":"{readStateIndex:25699; appliedIndex:25697; }","duration":"396.839772ms","start":"2026-06-06T17:52:08.398111Z","end":"2026-06-06T17:52:08.79495Z","steps":["trace[703197853] 'read index received'  (duration: 80.045513ms)","trace[703197853] 'applied index is now lower than readState.Index'  (duration: 316.791319ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:08.79499Z","caller":"traceutil/trace.go:171","msg":"trace[1510794060] transaction","detail":"{read_only:false; response_revision:24881; number_of_response:1; }","duration":"253.554362ms","start":"2026-06-06T17:52:08.541413Z","end":"2026-06-06T17:52:08.794967Z","steps":["trace[1510794060] 'process raft request'  (duration: 253.107111ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:08.795148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.343234ms","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-06-06T17:52:08.795183Z","caller":"traceutil/trace.go:171","msg":"trace[672354219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24882; }","duration":"322.428206ms","start":"2026-06-06T17:52:08.472747Z","end":"2026-06-06T17:52:08.795175Z","steps":["trace[672354219] 'agreement among raft nodes before linearized reading'  (duration: 322.316973ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:08.795149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.022727ms","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-06-06T17:52:08.795272Z","caller":"traceutil/trace.go:171","msg":"trace[1351687606] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24882; }","duration":"397.155249ms","start":"2026-06-06T17:52:08.398085Z","end":"2026-06-06T17:52:08.795241Z","steps":["trace[1351687606] 'agreement among raft nodes before linearized reading'  (duration: 396.962965ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:08.795208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:08.472727Z","time spent":"322.474196ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-06-06T17:52:08.795372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:08.398078Z","time spent":"397.264062ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-06-06T17:52:09.141807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.603678ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531495895 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24866 > 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-06-06T17:52:09.141974Z","caller":"traceutil/trace.go:171","msg":"trace[2143652982] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"153.376204ms","start":"2026-06-06T17:52:08.988582Z","end":"2026-06-06T17:52:09.141958Z","steps":["trace[2143652982] 'process raft request'  (duration: 153.320983ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:09.142169Z","caller":"traceutil/trace.go:171","msg":"trace[1498288802] linearizableReadLoop","detail":"{readStateIndex:25702; appliedIndex:25701; }","duration":"342.708425ms","start":"2026-06-06T17:52:08.799451Z","end":"2026-06-06T17:52:09.142159Z","steps":["trace[1498288802] 'read index received'  (duration: 140.714927ms)","trace[1498288802] 'applied index is now lower than readState.Index'  (duration: 201.992218ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:09.14216Z","caller":"traceutil/trace.go:171","msg":"trace[1269709021] transaction","detail":"{read_only:false; response_revision:24883; number_of_response:1; }","duration":"342.89698ms","start":"2026-06-06T17:52:08.799227Z","end":"2026-06-06T17:52:09.142124Z","steps":["trace[1269709021] 'process raft request'  (duration: 140.897712ms)","trace[1269709021] 'compare'  (duration: 201.501626ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:09.14231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:08.799205Z","time spent":"343.021312ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24866 > 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-06-06T17:52:09.142389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.936781ms","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-06-06T17:52:09.142423Z","caller":"traceutil/trace.go:171","msg":"trace[391487889] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24884; }","duration":"343.028283ms","start":"2026-06-06T17:52:08.799386Z","end":"2026-06-06T17:52:09.142414Z","steps":["trace[391487889] 'agreement among raft nodes before linearized reading'  (duration: 342.870599ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.142451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:08.799361Z","time spent":"343.083565ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-06-06T17:52:09.379105Z","caller":"traceutil/trace.go:171","msg":"trace[2034075298] transaction","detail":"{read_only:false; response_revision:24885; number_of_response:1; }","duration":"376.874791ms","start":"2026-06-06T17:52:09.002199Z","end":"2026-06-06T17:52:09.379074Z","steps":["trace[2034075298] 'process raft request'  (duration: 356.13099ms)","trace[2034075298] 'compare'  (duration: 20.28327ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:09.379259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.002179Z","time spent":"376.994074ms","remote":"127.0.0.1:52940","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:24871 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-06-06T17:52:09.379244Z","caller":"traceutil/trace.go:171","msg":"trace[448603738] linearizableReadLoop","detail":"{readStateIndex:25706; appliedIndex:25703; }","duration":"237.025244ms","start":"2026-06-06T17:52:09.142197Z","end":"2026-06-06T17:52:09.379222Z","steps":["trace[448603738] 'read index received'  (duration: 216.1735ms)","trace[448603738] 'applied index is now lower than readState.Index'  (duration: 20.850804ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:09.379458Z","caller":"traceutil/trace.go:171","msg":"trace[677402282] transaction","detail":"{read_only:false; response_revision:24887; number_of_response:1; }","duration":"377.050495ms","start":"2026-06-06T17:52:09.002397Z","end":"2026-06-06T17:52:09.379447Z","steps":["trace[677402282] 'process raft request'  (duration: 376.755388ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.379485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.818176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-06T17:52:09.379642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.126634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-06-06T17:52:09.379681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.406034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18420"}
{"level":"info","ts":"2026-06-06T17:52:09.379788Z","caller":"traceutil/trace.go:171","msg":"trace[1580179371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24887; }","duration":"344.943889ms","start":"2026-06-06T17:52:09.034595Z","end":"2026-06-06T17:52:09.379539Z","steps":["trace[1580179371] 'agreement among raft nodes before linearized reading'  (duration: 344.806006ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.379866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.034578Z","time spent":"345.274878ms","remote":"127.0.0.1:52666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-06-06T17:52:09.379511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.002377Z","time spent":"377.104637ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24872 > 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-06-06T17:52:09.380092Z","caller":"traceutil/trace.go:171","msg":"trace[257971858] transaction","detail":"{read_only:false; response_revision:24886; number_of_response:1; }","duration":"377.26525ms","start":"2026-06-06T17:52:09.002276Z","end":"2026-06-06T17:52:09.379541Z","steps":["trace[257971858] 'process raft request'  (duration: 376.674416ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.3799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.037488ms","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-06-06T17:52:09.380511Z","caller":"traceutil/trace.go:171","msg":"trace[1186551859] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24887; }","duration":"320.694534ms","start":"2026-06-06T17:52:09.059802Z","end":"2026-06-06T17:52:09.380497Z","steps":["trace[1186551859] 'agreement among raft nodes before linearized reading'  (duration: 319.894235ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.380186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.00225Z","time spent":"377.876025ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24869 > 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-06-06T17:52:09.380658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.059789Z","time spent":"320.829217ms","remote":"127.0.0.1:52748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":379,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"info","ts":"2026-06-06T17:52:09.380244Z","caller":"traceutil/trace.go:171","msg":"trace[330886232] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24887; }","duration":"379.229307ms","start":"2026-06-06T17:52:09.000452Z","end":"2026-06-06T17:52:09.379681Z","steps":["trace[330886232] 'agreement among raft nodes before linearized reading'  (duration: 379.072233ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.38073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.000432Z","time spent":"380.278612ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-06-06T17:52:09.380301Z","caller":"traceutil/trace.go:171","msg":"trace[1385699924] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24887; }","duration":"235.451345ms","start":"2026-06-06T17:52:09.144255Z","end":"2026-06-06T17:52:09.379706Z","steps":["trace[1385699924] 'agreement among raft nodes before linearized reading'  (duration: 235.313462ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:09.628111Z","caller":"traceutil/trace.go:171","msg":"trace[1687340745] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"165.371743ms","start":"2026-06-06T17:52:09.462714Z","end":"2026-06-06T17:52:09.628086Z","steps":["trace[1687340745] 'process raft request'  (duration: 113.677605ms)","trace[1687340745] 'compare'  (duration: 51.522884ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:09.769132Z","caller":"traceutil/trace.go:171","msg":"trace[2050833482] linearizableReadLoop","detail":"{readStateIndex:25710; appliedIndex:25707; }","duration":"304.692248ms","start":"2026-06-06T17:52:09.46441Z","end":"2026-06-06T17:52:09.769102Z","steps":["trace[2050833482] 'read index received'  (duration: 112.000485ms)","trace[2050833482] 'applied index is now lower than readState.Index'  (duration: 192.690403ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:09.769271Z","caller":"traceutil/trace.go:171","msg":"trace[109350730] transaction","detail":"{read_only:false; response_revision:24891; number_of_response:1; }","duration":"305.237121ms","start":"2026-06-06T17:52:09.464004Z","end":"2026-06-06T17:52:09.769241Z","steps":["trace[109350730] 'process raft request'  (duration: 304.965314ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:09.769184Z","caller":"traceutil/trace.go:171","msg":"trace[823114443] transaction","detail":"{read_only:false; response_revision:24890; number_of_response:1; }","duration":"305.560229ms","start":"2026-06-06T17:52:09.463565Z","end":"2026-06-06T17:52:09.769125Z","steps":["trace[823114443] 'process raft request'  (duration: 304.634177ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.769441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.463964Z","time spent":"305.394144ms","remote":"127.0.0.1:52940","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:24873 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-06-06T17:52:09.769402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.963635ms","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-06-06T17:52:09.769652Z","caller":"traceutil/trace.go:171","msg":"trace[2118504382] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24891; }","duration":"305.224691ms","start":"2026-06-06T17:52:09.464375Z","end":"2026-06-06T17:52:09.7696Z","steps":["trace[2118504382] 'agreement among raft nodes before linearized reading'  (duration: 304.846102ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:09.769699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.463551Z","time spent":"305.988169ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24875 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-06-06T17:52:09.769793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:09.464366Z","time spent":"305.395895ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-06-06T17:52:10.444796Z","caller":"traceutil/trace.go:171","msg":"trace[19655212] transaction","detail":"{read_only:false; response_revision:24894; number_of_response:1; }","duration":"180.679293ms","start":"2026-06-06T17:52:10.264086Z","end":"2026-06-06T17:52:10.444765Z","steps":["trace[19655212] 'process raft request'  (duration: 169.015451ms)","trace[19655212] 'compare'  (duration: 11.484567ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:16.688493Z","caller":"traceutil/trace.go:171","msg":"trace[1486982338] transaction","detail":"{read_only:false; response_revision:24938; number_of_response:1; }","duration":"222.172094ms","start":"2026-06-06T17:52:16.466295Z","end":"2026-06-06T17:52:16.688467Z","steps":["trace[1486982338] 'process raft request'  (duration: 221.99869ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:17.044296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.580064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531496031 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24923 > 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-06-06T17:52:17.045113Z","caller":"traceutil/trace.go:171","msg":"trace[1465096522] transaction","detail":"{read_only:false; response_revision:24941; number_of_response:1; }","duration":"213.440454ms","start":"2026-06-06T17:52:16.831643Z","end":"2026-06-06T17:52:17.045084Z","steps":["trace[1465096522] 'process raft request'  (duration: 212.830729ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:17.045177Z","caller":"traceutil/trace.go:171","msg":"trace[598839335] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"213.627778ms","start":"2026-06-06T17:52:16.831527Z","end":"2026-06-06T17:52:17.045155Z","steps":["trace[598839335] 'process raft request'  (duration: 212.88238ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:17.045157Z","caller":"traceutil/trace.go:171","msg":"trace[2050921375] transaction","detail":"{read_only:false; response_revision:24939; number_of_response:1; }","duration":"512.383833ms","start":"2026-06-06T17:52:16.532724Z","end":"2026-06-06T17:52:17.045108Z","steps":["trace[2050921375] 'process raft request'  (duration: 247.898417ms)","trace[2050921375] 'compare'  (duration: 263.460172ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:17.046392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:16.532692Z","time spent":"513.591692ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24923 > 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":"warn","ts":"2026-06-06T17:52:17.614608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.127742ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531496039 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.162\" mod_revision:24876 > success:<request_put:<key:\"/registry/masterleases/199.204.45.162\" value_size:68 lease:4862373148676720229 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.162\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:52:17.614688Z","caller":"traceutil/trace.go:171","msg":"trace[1325610419] transaction","detail":"{read_only:false; response_revision:24942; number_of_response:1; }","duration":"547.257706ms","start":"2026-06-06T17:52:17.067416Z","end":"2026-06-06T17:52:17.614674Z","steps":["trace[1325610419] 'process raft request'  (duration: 263.005071ms)","trace[1325610419] 'compare'  (duration: 284.033068ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:17.614728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.067398Z","time spent":"547.312157ms","remote":"127.0.0.1:52692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.162\" mod_revision:24876 > success:<request_put:<key:\"/registry/masterleases/199.204.45.162\" value_size:68 lease:4862373148676720229 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.162\" > >"}
{"level":"info","ts":"2026-06-06T17:52:17.617797Z","caller":"traceutil/trace.go:171","msg":"trace[938216813] linearizableReadLoop","detail":"{readStateIndex:25764; appliedIndex:25762; }","duration":"434.996785ms","start":"2026-06-06T17:52:17.182791Z","end":"2026-06-06T17:52:17.617788Z","steps":["trace[938216813] 'read index received'  (duration: 147.645115ms)","trace[938216813] 'applied index is now lower than readState.Index'  (duration: 287.35097ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:17.617965Z","caller":"traceutil/trace.go:171","msg":"trace[447337445] transaction","detail":"{read_only:false; response_revision:24943; number_of_response:1; }","duration":"437.979906ms","start":"2026-06-06T17:52:17.179962Z","end":"2026-06-06T17:52:17.617942Z","steps":["trace[447337445] 'process raft request'  (duration: 437.767301ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:17.618077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.17994Z","time spent":"438.073369ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24927 > 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-06-06T17:52:17.618103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.295263ms","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-06-06T17:52:17.618175Z","caller":"traceutil/trace.go:171","msg":"trace[1833569692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24943; }","duration":"435.407445ms","start":"2026-06-06T17:52:17.18275Z","end":"2026-06-06T17:52:17.618157Z","steps":["trace[1833569692] 'agreement among raft nodes before linearized reading'  (duration: 435.171939ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:17.618225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.182738Z","time spent":"435.473047ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-06-06T17:52:17.619103Z","caller":"traceutil/trace.go:171","msg":"trace[744016723] transaction","detail":"{read_only:false; response_revision:24944; number_of_response:1; }","duration":"215.454513ms","start":"2026-06-06T17:52:17.403636Z","end":"2026-06-06T17:52:17.619091Z","steps":["trace[744016723] 'process raft request'  (duration: 215.207797ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:17.619339Z","caller":"traceutil/trace.go:171","msg":"trace[738755769] transaction","detail":"{read_only:false; response_revision:24945; number_of_response:1; }","duration":"211.352473ms","start":"2026-06-06T17:52:17.40798Z","end":"2026-06-06T17:52:17.619332Z","steps":["trace[738755769] 'process raft request'  (duration: 210.970024ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:17.619434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.992134ms","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-06-06T17:52:17.619469Z","caller":"traceutil/trace.go:171","msg":"trace[399189618] transaction","detail":"{read_only:false; response_revision:24947; number_of_response:1; }","duration":"124.673471ms","start":"2026-06-06T17:52:17.49479Z","end":"2026-06-06T17:52:17.619464Z","steps":["trace[399189618] 'process raft request'  (duration: 124.531297ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:17.619493Z","caller":"traceutil/trace.go:171","msg":"trace[1569774484] 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:24947; }","duration":"158.084627ms","start":"2026-06-06T17:52:17.461395Z","end":"2026-06-06T17:52:17.619479Z","steps":["trace[1569774484] 'agreement among raft nodes before linearized reading'  (duration: 157.977974ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:17.619596Z","caller":"traceutil/trace.go:171","msg":"trace[1629210813] transaction","detail":"{read_only:false; response_revision:24946; number_of_response:1; }","duration":"211.402545ms","start":"2026-06-06T17:52:17.408188Z","end":"2026-06-06T17:52:17.61959Z","steps":["trace[1629210813] 'process raft request'  (duration: 211.030406ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:17.619809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.762937ms","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-06-06T17:52:17.619833Z","caller":"traceutil/trace.go:171","msg":"trace[765095376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24947; }","duration":"130.818468ms","start":"2026-06-06T17:52:17.48901Z","end":"2026-06-06T17:52:17.619828Z","steps":["trace[765095376] 'agreement among raft nodes before linearized reading'  (duration: 130.727196ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.124551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745185531496048,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-06-06T17:52:18.144843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.405506ms","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-06-06T17:52:18.144948Z","caller":"traceutil/trace.go:171","msg":"trace[1359261468] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24947; }","duration":"416.58618ms","start":"2026-06-06T17:52:17.728346Z","end":"2026-06-06T17:52:18.144932Z","steps":["trace[1359261468] 'range keys from in-memory index tree'  (duration: 416.392945ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:18.145431Z","caller":"traceutil/trace.go:171","msg":"trace[2004242823] transaction","detail":"{read_only:false; response_revision:24948; number_of_response:1; }","duration":"523.233646ms","start":"2026-06-06T17:52:17.622186Z","end":"2026-06-06T17:52:18.14542Z","steps":["trace[2004242823] 'process raft request'  (duration: 521.456772ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.145518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.622174Z","time spent":"523.301277ms","remote":"127.0.0.1:52940","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:24928 > 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-06-06T17:52:18.164285Z","caller":"traceutil/trace.go:171","msg":"trace[1517900473] linearizableReadLoop","detail":"{readStateIndex:25770; appliedIndex:25768; }","duration":"540.629015ms","start":"2026-06-06T17:52:17.623635Z","end":"2026-06-06T17:52:18.164264Z","steps":["trace[1517900473] 'read index received'  (duration: 519.936985ms)","trace[1517900473] 'applied index is now lower than readState.Index'  (duration: 20.6912ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:18.164629Z","caller":"traceutil/trace.go:171","msg":"trace[1046849282] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"541.452574ms","start":"2026-06-06T17:52:17.623166Z","end":"2026-06-06T17:52:18.164619Z","steps":["trace[1046849282] 'process raft request'  (duration: 540.975973ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.164735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.62316Z","time spent":"541.501455ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24932 > 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-06-06T17:52:18.165032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.376322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-06-06T17:52:18.165074Z","caller":"traceutil/trace.go:171","msg":"trace[1411661045] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24949; }","duration":"541.445375ms","start":"2026-06-06T17:52:17.623619Z","end":"2026-06-06T17:52:18.165064Z","steps":["trace[1411661045] 'agreement among raft nodes before linearized reading'  (duration: 541.299701ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.165101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.623613Z","time spent":"541.482795ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-06-06T17:52:18.165345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.788288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:18.165386Z","caller":"traceutil/trace.go:171","msg":"trace[1626545230] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24949; }","duration":"540.83955ms","start":"2026-06-06T17:52:17.624537Z","end":"2026-06-06T17:52:18.165377Z","steps":["trace[1626545230] 'agreement among raft nodes before linearized reading'  (duration: 540.775578ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.165416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.624532Z","time spent":"540.875811ms","remote":"127.0.0.1:52854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-06-06T17:52:18.165436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.552452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:18.165535Z","caller":"traceutil/trace.go:171","msg":"trace[1319853928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24949; }","duration":"130.704855ms","start":"2026-06-06T17:52:18.03481Z","end":"2026-06-06T17:52:18.165515Z","steps":["trace[1319853928] 'agreement among raft nodes before linearized reading'  (duration: 130.522021ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.165588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.690076ms","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-06-06T17:52:18.165627Z","caller":"traceutil/trace.go:171","msg":"trace[1684525276] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24949; }","duration":"294.756928ms","start":"2026-06-06T17:52:17.870859Z","end":"2026-06-06T17:52:18.165616Z","steps":["trace[1684525276] 'agreement among raft nodes before linearized reading'  (duration: 294.694206ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.16584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.437117ms","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-06-06T17:52:18.165893Z","caller":"traceutil/trace.go:171","msg":"trace[1018847678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24949; }","duration":"344.531359ms","start":"2026-06-06T17:52:17.821353Z","end":"2026-06-06T17:52:18.165884Z","steps":["trace[1018847678] 'agreement among raft nodes before linearized reading'  (duration: 344.425167ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.165921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.821312Z","time spent":"344.601991ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-06-06T17:52:18.166114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.790195ms","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-06-06T17:52:18.166153Z","caller":"traceutil/trace.go:171","msg":"trace[962138116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24949; }","duration":"344.872467ms","start":"2026-06-06T17:52:17.821272Z","end":"2026-06-06T17:52:18.166145Z","steps":["trace[962138116] 'agreement among raft nodes before linearized reading'  (duration: 344.776915ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.166179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.821251Z","time spent":"344.921449ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-06-06T17:52:18.166282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.993551ms","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-06-06T17:52:18.166334Z","caller":"traceutil/trace.go:171","msg":"trace[1494050725] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24949; }","duration":"461.071103ms","start":"2026-06-06T17:52:17.705248Z","end":"2026-06-06T17:52:18.166319Z","steps":["trace[1494050725] 'agreement among raft nodes before linearized reading'  (duration: 460.989172ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.166373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.705234Z","time spent":"461.129326ms","remote":"127.0.0.1:58884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-06-06T17:52:18.166479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.382289ms","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-06-06T17:52:18.166517Z","caller":"traceutil/trace.go:171","msg":"trace[999742130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24949; }","duration":"511.42957ms","start":"2026-06-06T17:52:17.655078Z","end":"2026-06-06T17:52:18.166508Z","steps":["trace[999742130] 'agreement among raft nodes before linearized reading'  (duration: 511.335058ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.166547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:17.655073Z","time spent":"511.467771ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-06-06T17:52:18.433463Z","caller":"traceutil/trace.go:171","msg":"trace[1998374801] linearizableReadLoop","detail":"{readStateIndex:25773; appliedIndex:25770; }","duration":"261.664159ms","start":"2026-06-06T17:52:18.171776Z","end":"2026-06-06T17:52:18.43344Z","steps":["trace[1998374801] 'read index received'  (duration: 256.604846ms)","trace[1998374801] 'applied index is now lower than readState.Index'  (duration: 5.058133ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:18.433494Z","caller":"traceutil/trace.go:171","msg":"trace[487496006] transaction","detail":"{read_only:false; response_revision:24950; number_of_response:1; }","duration":"263.031962ms","start":"2026-06-06T17:52:18.170426Z","end":"2026-06-06T17:52:18.433458Z","steps":["trace[487496006] 'process raft request'  (duration: 257.857727ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:18.433602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.815513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:18.433961Z","caller":"traceutil/trace.go:171","msg":"trace[845886803] transaction","detail":"{read_only:false; response_revision:24951; number_of_response:1; }","duration":"263.441342ms","start":"2026-06-06T17:52:18.170511Z","end":"2026-06-06T17:52:18.433952Z","steps":["trace[845886803] 'process raft request'  (duration: 262.716695ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:18.434007Z","caller":"traceutil/trace.go:171","msg":"trace[51466887] transaction","detail":"{read_only:false; response_revision:24952; number_of_response:1; }","duration":"263.352839ms","start":"2026-06-06T17:52:18.170641Z","end":"2026-06-06T17:52:18.433994Z","steps":["trace[51466887] 'process raft request'  (duration: 262.757015ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:18.433638Z","caller":"traceutil/trace.go:171","msg":"trace[1204595670] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24952; }","duration":"261.880634ms","start":"2026-06-06T17:52:18.171746Z","end":"2026-06-06T17:52:18.433627Z","steps":["trace[1204595670] 'agreement among raft nodes before linearized reading'  (duration: 261.784282ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:23.744022Z","caller":"traceutil/trace.go:171","msg":"trace[2038040064] transaction","detail":"{read_only:false; response_revision:25043; number_of_response:1; }","duration":"107.310021ms","start":"2026-06-06T17:52:23.636688Z","end":"2026-06-06T17:52:23.743998Z","steps":["trace[2038040064] 'process raft request'  (duration: 107.180358ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:23.906734Z","caller":"traceutil/trace.go:171","msg":"trace[2093151604] transaction","detail":"{read_only:false; response_revision:25044; number_of_response:1; }","duration":"267.110241ms","start":"2026-06-06T17:52:23.639606Z","end":"2026-06-06T17:52:23.906717Z","steps":["trace[2093151604] 'process raft request'  (duration: 266.945187ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:23.907104Z","caller":"traceutil/trace.go:171","msg":"trace[1952877145] transaction","detail":"{read_only:false; response_revision:25046; number_of_response:1; }","duration":"260.639474ms","start":"2026-06-06T17:52:23.646453Z","end":"2026-06-06T17:52:23.907092Z","steps":["trace[1952877145] 'process raft request'  (duration: 260.452149ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:23.907084Z","caller":"traceutil/trace.go:171","msg":"trace[108591316] linearizableReadLoop","detail":"{readStateIndex:25869; appliedIndex:25866; }","duration":"150.347201ms","start":"2026-06-06T17:52:23.756711Z","end":"2026-06-06T17:52:23.907059Z","steps":["trace[108591316] 'read index received'  (duration: 149.88104ms)","trace[108591316] 'applied index is now lower than readState.Index'  (duration: 465.181µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:23.90718Z","caller":"traceutil/trace.go:171","msg":"trace[1912299099] transaction","detail":"{read_only:false; response_revision:25045; number_of_response:1; }","duration":"265.294446ms","start":"2026-06-06T17:52:23.64188Z","end":"2026-06-06T17:52:23.907174Z","steps":["trace[1912299099] 'process raft request'  (duration: 264.811465ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:23.90731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.574386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-06T17:52:23.907363Z","caller":"traceutil/trace.go:171","msg":"trace[835678203] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:25046; }","duration":"150.676359ms","start":"2026-06-06T17:52:23.75667Z","end":"2026-06-06T17:52:23.907347Z","steps":["trace[835678203] 'agreement among raft nodes before linearized reading'  (duration: 150.513025ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:24.043614Z","caller":"traceutil/trace.go:171","msg":"trace[852025332] transaction","detail":"{read_only:false; response_revision:25047; number_of_response:1; }","duration":"239.040411ms","start":"2026-06-06T17:52:23.804537Z","end":"2026-06-06T17:52:24.043577Z","steps":["trace[852025332] 'process raft request'  (duration: 238.698773ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:24.24457Z","caller":"traceutil/trace.go:171","msg":"trace[1438069971] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"115.684393ms","start":"2026-06-06T17:52:24.128828Z","end":"2026-06-06T17:52:24.244513Z","steps":["trace[1438069971] 'process raft request'  (duration: 115.479899ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:24.370394Z","caller":"traceutil/trace.go:171","msg":"trace[92063884] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"121.34811ms","start":"2026-06-06T17:52:24.249021Z","end":"2026-06-06T17:52:24.370369Z","steps":["trace[92063884] 'process raft request'  (duration: 105.031686ms)","trace[92063884] 'compare'  (duration: 16.208891ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:24.444496Z","caller":"traceutil/trace.go:171","msg":"trace[1194306818] transaction","detail":"{read_only:false; response_revision:25050; number_of_response:1; }","duration":"195.413649ms","start":"2026-06-06T17:52:24.24905Z","end":"2026-06-06T17:52:24.444464Z","steps":["trace[1194306818] 'process raft request'  (duration: 195.131891ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:26.538675Z","caller":"traceutil/trace.go:171","msg":"trace[272903568] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"161.206152ms","start":"2026-06-06T17:52:26.377434Z","end":"2026-06-06T17:52:26.53864Z","steps":["trace[272903568] 'process raft request'  (duration: 160.991307ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:29.217976Z","caller":"traceutil/trace.go:171","msg":"trace[1949700854] transaction","detail":"{read_only:false; response_revision:25102; number_of_response:1; }","duration":"130.379728ms","start":"2026-06-06T17:52:29.08755Z","end":"2026-06-06T17:52:29.21793Z","steps":["trace[1949700854] 'process raft request'  (duration: 130.108461ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:29.360276Z","caller":"traceutil/trace.go:171","msg":"trace[460111694] linearizableReadLoop","detail":"{readStateIndex:25929; appliedIndex:25926; }","duration":"163.974729ms","start":"2026-06-06T17:52:29.196273Z","end":"2026-06-06T17:52:29.360248Z","steps":["trace[460111694] 'read index received'  (duration: 21.434247ms)","trace[460111694] 'applied index is now lower than readState.Index'  (duration: 142.539492ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:29.360296Z","caller":"traceutil/trace.go:171","msg":"trace[1034459455] transaction","detail":"{read_only:false; response_revision:25103; number_of_response:1; }","duration":"272.285585ms","start":"2026-06-06T17:52:29.087984Z","end":"2026-06-06T17:52:29.36027Z","steps":["trace[1034459455] 'process raft request'  (duration: 272.021878ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:29.360399Z","caller":"traceutil/trace.go:171","msg":"trace[2009479345] transaction","detail":"{read_only:false; response_revision:25104; number_of_response:1; }","duration":"271.892886ms","start":"2026-06-06T17:52:29.088494Z","end":"2026-06-06T17:52:29.360387Z","steps":["trace[2009479345] 'process raft request'  (duration: 271.704291ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:29.360491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.195304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:29.360545Z","caller":"traceutil/trace.go:171","msg":"trace[1150326010] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25104; }","duration":"164.298487ms","start":"2026-06-06T17:52:29.196234Z","end":"2026-06-06T17:52:29.360532Z","steps":["trace[1150326010] 'agreement among raft nodes before linearized reading'  (duration: 164.201515ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:29.537326Z","caller":"traceutil/trace.go:171","msg":"trace[420731070] linearizableReadLoop","detail":"{readStateIndex:25930; appliedIndex:25929; }","duration":"176.950433ms","start":"2026-06-06T17:52:29.360349Z","end":"2026-06-06T17:52:29.537299Z","steps":["trace[420731070] 'read index received'  (duration: 121.959815ms)","trace[420731070] 'applied index is now lower than readState.Index'  (duration: 54.989638ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:29.537409Z","caller":"traceutil/trace.go:171","msg":"trace[554960288] transaction","detail":"{read_only:false; response_revision:25105; number_of_response:1; }","duration":"180.154961ms","start":"2026-06-06T17:52:29.357211Z","end":"2026-06-06T17:52:29.537366Z","steps":["trace[554960288] 'process raft request'  (duration: 125.128982ms)","trace[554960288] 'compare'  (duration: 54.773822ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:29.537503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.250276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:29.537538Z","caller":"traceutil/trace.go:171","msg":"trace[1038117073] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:25105; }","duration":"299.353629ms","start":"2026-06-06T17:52:29.238175Z","end":"2026-06-06T17:52:29.537528Z","steps":["trace[1038117073] 'agreement among raft nodes before linearized reading'  (duration: 299.230636ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:32.421274Z","caller":"traceutil/trace.go:171","msg":"trace[74735204] transaction","detail":"{read_only:false; response_revision:25132; number_of_response:1; }","duration":"128.286408ms","start":"2026-06-06T17:52:32.292961Z","end":"2026-06-06T17:52:32.421247Z","steps":["trace[74735204] 'process raft request'  (duration: 128.104184ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:32.429057Z","caller":"traceutil/trace.go:171","msg":"trace[796449415] transaction","detail":"{read_only:false; response_revision:25133; number_of_response:1; }","duration":"127.684134ms","start":"2026-06-06T17:52:32.301353Z","end":"2026-06-06T17:52:32.429037Z","steps":["trace[796449415] 'process raft request'  (duration: 127.499379ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:35.103383Z","caller":"traceutil/trace.go:171","msg":"trace[36033894] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"130.096111ms","start":"2026-06-06T17:52:34.973261Z","end":"2026-06-06T17:52:35.103357Z","steps":["trace[36033894] 'process raft request'  (duration: 129.727743ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:35.310914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.226901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:35.310997Z","caller":"traceutil/trace.go:171","msg":"trace[1365592254] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25158; }","duration":"100.358624ms","start":"2026-06-06T17:52:35.210623Z","end":"2026-06-06T17:52:35.310982Z","steps":["trace[1365592254] 'range keys from in-memory index tree'  (duration: 100.161289ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:37.485918Z","caller":"traceutil/trace.go:171","msg":"trace[662259696] transaction","detail":"{read_only:false; response_revision:25176; number_of_response:1; }","duration":"101.449219ms","start":"2026-06-06T17:52:37.384443Z","end":"2026-06-06T17:52:37.485892Z","steps":["trace[662259696] 'process raft request'  (duration: 101.155582ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:37.707701Z","caller":"traceutil/trace.go:171","msg":"trace[1829972177] linearizableReadLoop","detail":"{readStateIndex:26005; appliedIndex:26004; }","duration":"133.592386ms","start":"2026-06-06T17:52:37.574081Z","end":"2026-06-06T17:52:37.707674Z","steps":["trace[1829972177] 'read index received'  (duration: 54.187539ms)","trace[1829972177] 'applied index is now lower than readState.Index'  (duration: 79.403577ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:37.707886Z","caller":"traceutil/trace.go:171","msg":"trace[2051818906] transaction","detail":"{read_only:false; response_revision:25178; number_of_response:1; }","duration":"138.605816ms","start":"2026-06-06T17:52:37.569256Z","end":"2026-06-06T17:52:37.707862Z","steps":["trace[2051818906] 'process raft request'  (duration: 59.000055ms)","trace[2051818906] 'compare'  (duration: 79.232272ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:37.707977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.872142ms","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-06-06T17:52:37.708033Z","caller":"traceutil/trace.go:171","msg":"trace[1379637825] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25178; }","duration":"133.957705ms","start":"2026-06-06T17:52:37.57406Z","end":"2026-06-06T17:52:37.708018Z","steps":["trace[1379637825] 'agreement among raft nodes before linearized reading'  (duration: 133.724449ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:37.93582Z","caller":"traceutil/trace.go:171","msg":"trace[1207491296] transaction","detail":"{read_only:false; response_revision:25180; number_of_response:1; }","duration":"150.641688ms","start":"2026-06-06T17:52:37.785147Z","end":"2026-06-06T17:52:37.935789Z","steps":["trace[1207491296] 'process raft request'  (duration: 150.483363ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:54.816669Z","caller":"traceutil/trace.go:171","msg":"trace[2022564176] transaction","detail":"{read_only:false; response_revision:25316; number_of_response:1; }","duration":"124.2436ms","start":"2026-06-06T17:52:54.69237Z","end":"2026-06-06T17:52:54.816614Z","steps":["trace[2022564176] 'process raft request'  (duration: 123.945223ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:55.043735Z","caller":"traceutil/trace.go:171","msg":"trace[1950391143] transaction","detail":"{read_only:false; response_revision:25318; number_of_response:1; }","duration":"223.434456ms","start":"2026-06-06T17:52:54.820272Z","end":"2026-06-06T17:52:55.043707Z","steps":["trace[1950391143] 'process raft request'  (duration: 143.797412ms)","trace[1950391143] 'compare'  (duration: 79.51782ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:55.059605Z","caller":"traceutil/trace.go:171","msg":"trace[833053583] transaction","detail":"{read_only:false; response_revision:25320; number_of_response:1; }","duration":"163.374464ms","start":"2026-06-06T17:52:54.896212Z","end":"2026-06-06T17:52:55.059586Z","steps":["trace[833053583] 'process raft request'  (duration: 163.283292ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:55.059653Z","caller":"traceutil/trace.go:171","msg":"trace[997543158] transaction","detail":"{read_only:false; response_revision:25321; number_of_response:1; }","duration":"163.227561ms","start":"2026-06-06T17:52:54.8964Z","end":"2026-06-06T17:52:55.059628Z","steps":["trace[997543158] 'process raft request'  (duration: 163.133279ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:55.05973Z","caller":"traceutil/trace.go:171","msg":"trace[1834885563] transaction","detail":"{read_only:false; response_revision:25319; number_of_response:1; }","duration":"164.274777ms","start":"2026-06-06T17:52:54.895445Z","end":"2026-06-06T17:52:55.05972Z","steps":["trace[1834885563] 'process raft request'  (duration: 163.874157ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:55.277981Z","caller":"traceutil/trace.go:171","msg":"trace[569805867] transaction","detail":"{read_only:false; response_revision:25322; number_of_response:1; }","duration":"145.308358ms","start":"2026-06-06T17:52:55.132644Z","end":"2026-06-06T17:52:55.277952Z","steps":["trace[569805867] 'process raft request'  (duration: 56.928585ms)","trace[569805867] 'compare'  (duration: 88.23031ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:55.750928Z","caller":"traceutil/trace.go:171","msg":"trace[2030385958] transaction","detail":"{read_only:false; response_revision:25326; number_of_response:1; }","duration":"212.369509ms","start":"2026-06-06T17:52:55.538461Z","end":"2026-06-06T17:52:55.750831Z","steps":["trace[2030385958] 'process raft request'  (duration: 148.558327ms)","trace[2030385958] 'compare'  (duration: 63.438983ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:56.992947Z","caller":"traceutil/trace.go:171","msg":"trace[1906498998] transaction","detail":"{read_only:false; response_revision:25331; number_of_response:1; }","duration":"167.459473ms","start":"2026-06-06T17:52:56.825463Z","end":"2026-06-06T17:52:56.992922Z","steps":["trace[1906498998] 'process raft request'  (duration: 167.316599ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.188953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.643039ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531496999 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25317 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:52:57.189057Z","caller":"traceutil/trace.go:171","msg":"trace[813941297] linearizableReadLoop","detail":"{readStateIndex:26162; appliedIndex:26160; }","duration":"227.37841ms","start":"2026-06-06T17:52:56.96166Z","end":"2026-06-06T17:52:57.189039Z","steps":["trace[813941297] 'read index received'  (duration: 31.095481ms)","trace[813941297] 'applied index is now lower than readState.Index'  (duration: 196.281879ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:57.189144Z","caller":"traceutil/trace.go:171","msg":"trace[1945567780] transaction","detail":"{read_only:false; response_revision:25332; number_of_response:1; }","duration":"291.799326ms","start":"2026-06-06T17:52:56.897334Z","end":"2026-06-06T17:52:57.189133Z","steps":["trace[1945567780] 'process raft request'  (duration: 159.88425ms)","trace[1945567780] 'compare'  (duration: 131.446904ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:52:57.189309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.637011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:52:57.18939Z","caller":"traceutil/trace.go:171","msg":"trace[248298790] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:25332; }","duration":"175.787594ms","start":"2026-06-06T17:52:57.013581Z","end":"2026-06-06T17:52:57.189368Z","steps":["trace[248298790] 'agreement among raft nodes before linearized reading'  (duration: 175.62323ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.1894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.733499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:140"}
{"level":"warn","ts":"2026-06-06T17:52:57.189382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.992992ms","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-06-06T17:52:57.18944Z","caller":"traceutil/trace.go:171","msg":"trace[304243548] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:25332; }","duration":"227.805371ms","start":"2026-06-06T17:52:56.961623Z","end":"2026-06-06T17:52:57.189428Z","steps":["trace[304243548] 'agreement among raft nodes before linearized reading'  (duration: 227.638247ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.18941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.067359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-06-06T17:52:57.18942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.042854ms","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-06-06T17:52:57.18949Z","caller":"traceutil/trace.go:171","msg":"trace[1378930011] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25332; }","duration":"125.177223ms","start":"2026-06-06T17:52:57.064292Z","end":"2026-06-06T17:52:57.189469Z","steps":["trace[1378930011] 'agreement among raft nodes before linearized reading'  (duration: 124.906966ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:57.189523Z","caller":"traceutil/trace.go:171","msg":"trace[186872802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25332; }","duration":"126.185447ms","start":"2026-06-06T17:52:57.063311Z","end":"2026-06-06T17:52:57.189497Z","steps":["trace[186872802] 'agreement among raft nodes before linearized reading'  (duration: 125.903701ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:57.189459Z","caller":"traceutil/trace.go:171","msg":"trace[63327572] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25332; }","duration":"126.085375ms","start":"2026-06-06T17:52:57.063355Z","end":"2026-06-06T17:52:57.189441Z","steps":["trace[63327572] 'agreement among raft nodes before linearized reading'  (duration: 125.915161ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.189382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.23204ms","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-06-06T17:52:57.189712Z","caller":"traceutil/trace.go:171","msg":"trace[993172253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25332; }","duration":"141.62097ms","start":"2026-06-06T17:52:57.048079Z","end":"2026-06-06T17:52:57.1897Z","steps":["trace[993172253] 'agreement among raft nodes before linearized reading'  (duration: 141.169988ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.492557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.367003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531497005 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25321 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:52:57.492749Z","caller":"traceutil/trace.go:171","msg":"trace[1967417068] transaction","detail":"{read_only:false; response_revision:25333; number_of_response:1; }","duration":"298.511199ms","start":"2026-06-06T17:52:57.194209Z","end":"2026-06-06T17:52:57.49272Z","steps":["trace[1967417068] 'process raft request'  (duration: 178.8721ms)","trace[1967417068] 'compare'  (duration: 119.225589ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:57.492854Z","caller":"traceutil/trace.go:171","msg":"trace[1071490099] transaction","detail":"{read_only:false; response_revision:25336; number_of_response:1; }","duration":"298.464848ms","start":"2026-06-06T17:52:57.194371Z","end":"2026-06-06T17:52:57.492836Z","steps":["trace[1071490099] 'process raft request'  (duration: 298.396306ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:57.492942Z","caller":"traceutil/trace.go:171","msg":"trace[451827271] transaction","detail":"{read_only:false; response_revision:25334; number_of_response:1; }","duration":"298.705424ms","start":"2026-06-06T17:52:57.194205Z","end":"2026-06-06T17:52:57.49291Z","steps":["trace[451827271] 'process raft request'  (duration: 298.450258ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:57.493017Z","caller":"traceutil/trace.go:171","msg":"trace[1826233254] transaction","detail":"{read_only:false; response_revision:25335; number_of_response:1; }","duration":"298.665103ms","start":"2026-06-06T17:52:57.194323Z","end":"2026-06-06T17:52:57.492989Z","steps":["trace[1826233254] 'process raft request'  (duration: 298.402876ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:57.550218Z","caller":"traceutil/trace.go:171","msg":"trace[817385393] transaction","detail":"{read_only:false; response_revision:25337; number_of_response:1; }","duration":"328.761739ms","start":"2026-06-06T17:52:57.221435Z","end":"2026-06-06T17:52:57.550197Z","steps":["trace[817385393] 'process raft request'  (duration: 328.589385ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.550372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:52:57.221409Z","time spent":"328.868231ms","remote":"127.0.0.1:52692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.162\" mod_revision:25251 > success:<request_put:<key:\"/registry/masterleases/199.204.45.162\" value_size:68 lease:4862373148676721194 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.162\" > >"}
{"level":"info","ts":"2026-06-06T17:52:57.67213Z","caller":"traceutil/trace.go:171","msg":"trace[1460009306] linearizableReadLoop","detail":"{readStateIndex:26169; appliedIndex:26168; }","duration":"120.0774ms","start":"2026-06-06T17:52:57.552032Z","end":"2026-06-06T17:52:57.672109Z","steps":["trace[1460009306] 'read index received'  (duration: 111.37616ms)","trace[1460009306] 'applied index is now lower than readState.Index'  (duration: 8.69977ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:52:57.672279Z","caller":"traceutil/trace.go:171","msg":"trace[144927893] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"246.657686ms","start":"2026-06-06T17:52:57.42559Z","end":"2026-06-06T17:52:57.672247Z","steps":["trace[144927893] 'process raft request'  (duration: 237.817303ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:52:57.672397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.342966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"}
{"level":"info","ts":"2026-06-06T17:52:57.67248Z","caller":"traceutil/trace.go:171","msg":"trace[1488918468] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25338; }","duration":"120.462298ms","start":"2026-06-06T17:52:57.551997Z","end":"2026-06-06T17:52:57.672459Z","steps":["trace[1488918468] 'agreement among raft nodes before linearized reading'  (duration: 120.236163ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:52:57.688582Z","caller":"traceutil/trace.go:171","msg":"trace[163569384] transaction","detail":"{read_only:false; response_revision:25339; number_of_response:1; }","duration":"106.956763ms","start":"2026-06-06T17:52:57.581602Z","end":"2026-06-06T17:52:57.688559Z","steps":["trace[163569384] 'process raft request'  (duration: 106.726848ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:05.154994Z","caller":"traceutil/trace.go:171","msg":"trace[497380285] linearizableReadLoop","detail":"{readStateIndex:26221; appliedIndex:26220; }","duration":"120.242573ms","start":"2026-06-06T17:53:05.034728Z","end":"2026-06-06T17:53:05.15497Z","steps":["trace[497380285] 'read index received'  (duration: 120.032058ms)","trace[497380285] 'applied index is now lower than readState.Index'  (duration: 209.645µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:53:05.155136Z","caller":"traceutil/trace.go:171","msg":"trace[606462507] transaction","detail":"{read_only:false; response_revision:25389; number_of_response:1; }","duration":"125.787498ms","start":"2026-06-06T17:53:05.029336Z","end":"2026-06-06T17:53:05.155124Z","steps":["trace[606462507] 'process raft request'  (duration: 125.48263ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:05.155349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.606723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:53:05.155407Z","caller":"traceutil/trace.go:171","msg":"trace[1527932807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25389; }","duration":"120.708145ms","start":"2026-06-06T17:53:05.034684Z","end":"2026-06-06T17:53:05.155392Z","steps":["trace[1527932807] 'agreement among raft nodes before linearized reading'  (duration: 120.628373ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:10.541999Z","caller":"traceutil/trace.go:171","msg":"trace[2133247627] transaction","detail":"{read_only:false; response_revision:25439; number_of_response:1; }","duration":"114.853953ms","start":"2026-06-06T17:53:10.427116Z","end":"2026-06-06T17:53:10.54197Z","steps":["trace[2133247627] 'process raft request'  (duration: 114.688989ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:11.114854Z","caller":"traceutil/trace.go:171","msg":"trace[1080985806] linearizableReadLoop","detail":"{readStateIndex:26273; appliedIndex:26272; }","duration":"113.804038ms","start":"2026-06-06T17:53:11.001021Z","end":"2026-06-06T17:53:11.114825Z","steps":["trace[1080985806] 'read index received'  (duration: 113.553012ms)","trace[1080985806] 'applied index is now lower than readState.Index'  (duration: 249.926µs)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:53:11.115103Z","caller":"traceutil/trace.go:171","msg":"trace[731377203] transaction","detail":"{read_only:false; response_revision:25440; number_of_response:1; }","duration":"123.320078ms","start":"2026-06-06T17:53:10.991755Z","end":"2026-06-06T17:53:11.115075Z","steps":["trace[731377203] 'process raft request'  (duration: 122.899118ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:11.115197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.165947ms","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-06-06T17:53:11.115259Z","caller":"traceutil/trace.go:171","msg":"trace[335845653] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25440; }","duration":"114.257509ms","start":"2026-06-06T17:53:11.000986Z","end":"2026-06-06T17:53:11.115244Z","steps":["trace[335845653] 'agreement among raft nodes before linearized reading'  (duration: 114.032962ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:13.177117Z","caller":"traceutil/trace.go:171","msg":"trace[331021685] linearizableReadLoop","detail":"{readStateIndex:26293; appliedIndex:26292; }","duration":"145.143765ms","start":"2026-06-06T17:53:13.031946Z","end":"2026-06-06T17:53:13.17709Z","steps":["trace[331021685] 'read index received'  (duration: 144.875138ms)","trace[331021685] 'applied index is now lower than readState.Index'  (duration: 267.447µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:13.177267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.292089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:53:13.17729Z","caller":"traceutil/trace.go:171","msg":"trace[820625001] transaction","detail":"{read_only:false; response_revision:25459; number_of_response:1; }","duration":"208.313991ms","start":"2026-06-06T17:53:12.968925Z","end":"2026-06-06T17:53:13.177239Z","steps":["trace[820625001] 'process raft request'  (duration: 207.962802ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:13.177467Z","caller":"traceutil/trace.go:171","msg":"trace[849380251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25459; }","duration":"145.387671ms","start":"2026-06-06T17:53:13.031905Z","end":"2026-06-06T17:53:13.177293Z","steps":["trace[849380251] 'agreement among raft nodes before linearized reading'  (duration: 145.291999ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:13.301275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.447402ms","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-06-06T17:53:13.301358Z","caller":"traceutil/trace.go:171","msg":"trace[967442151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25459; }","duration":"116.555536ms","start":"2026-06-06T17:53:13.184785Z","end":"2026-06-06T17:53:13.30134Z","steps":["trace[967442151] 'range keys from in-memory index tree'  (duration: 116.32133ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:14.226399Z","caller":"traceutil/trace.go:171","msg":"trace[1668267124] transaction","detail":"{read_only:false; response_revision:25469; number_of_response:1; }","duration":"124.391544ms","start":"2026-06-06T17:53:14.101981Z","end":"2026-06-06T17:53:14.226372Z","steps":["trace[1668267124] 'process raft request'  (duration: 124.22949ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:14.463037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.582547ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531497311 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25456 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:53:14.463276Z","caller":"traceutil/trace.go:171","msg":"trace[1937819362] linearizableReadLoop","detail":"{readStateIndex:26306; appliedIndex:26303; }","duration":"200.081592ms","start":"2026-06-06T17:53:14.263179Z","end":"2026-06-06T17:53:14.463261Z","steps":["trace[1937819362] 'read index received'  (duration: 90.156687ms)","trace[1937819362] 'applied index is now lower than readState.Index'  (duration: 109.924075ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:14.463387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.208835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:53:14.463426Z","caller":"traceutil/trace.go:171","msg":"trace[1103183637] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:25472; }","duration":"200.277927ms","start":"2026-06-06T17:53:14.263135Z","end":"2026-06-06T17:53:14.463413Z","steps":["trace[1103183637] 'agreement among raft nodes before linearized reading'  (duration: 200.179275ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:14.463434Z","caller":"traceutil/trace.go:171","msg":"trace[1549630257] transaction","detail":"{read_only:false; response_revision:25471; number_of_response:1; }","duration":"306.219635ms","start":"2026-06-06T17:53:14.157185Z","end":"2026-06-06T17:53:14.463405Z","steps":["trace[1549630257] 'process raft request'  (duration: 305.948758ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:14.463703Z","caller":"traceutil/trace.go:171","msg":"trace[585122036] transaction","detail":"{read_only:false; response_revision:25472; number_of_response:1; }","duration":"306.477902ms","start":"2026-06-06T17:53:14.157214Z","end":"2026-06-06T17:53:14.463691Z","steps":["trace[585122036] 'process raft request'  (duration: 306.00192ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:14.463726Z","caller":"traceutil/trace.go:171","msg":"trace[2064293500] transaction","detail":"{read_only:false; response_revision:25470; number_of_response:1; }","duration":"306.539052ms","start":"2026-06-06T17:53:14.15715Z","end":"2026-06-06T17:53:14.463689Z","steps":["trace[2064293500] 'process raft request'  (duration: 196.210758ms)","trace[2064293500] 'compare'  (duration: 109.32551ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:14.463918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:14.157129Z","time spent":"306.696477ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25456 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-06T17:53:14.463775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:14.157189Z","time spent":"306.552173ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25455 > 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-06-06T17:53:14.463932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:14.157157Z","time spent":"306.546353ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25457 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-06-06T17:53:15.595481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.725447ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531497318 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25460 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:53:15.595779Z","caller":"traceutil/trace.go:171","msg":"trace[2096839285] transaction","detail":"{read_only:false; response_revision:25474; number_of_response:1; }","duration":"259.805224ms","start":"2026-06-06T17:53:15.335861Z","end":"2026-06-06T17:53:15.595666Z","steps":["trace[2096839285] 'process raft request'  (duration: 135.768909ms)","trace[2096839285] 'compare'  (duration: 123.608605ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:53:15.595708Z","caller":"traceutil/trace.go:171","msg":"trace[615586804] linearizableReadLoop","detail":"{readStateIndex:26308; appliedIndex:26306; }","duration":"230.427374ms","start":"2026-06-06T17:53:15.365261Z","end":"2026-06-06T17:53:15.595689Z","steps":["trace[615586804] 'read index received'  (duration: 7.401328ms)","trace[615586804] 'applied index is now lower than readState.Index'  (duration: 222.980394ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:15.596058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.789883ms","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-06-06T17:53:15.59616Z","caller":"traceutil/trace.go:171","msg":"trace[146366003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25474; }","duration":"230.901025ms","start":"2026-06-06T17:53:15.36524Z","end":"2026-06-06T17:53:15.596141Z","steps":["trace[146366003] 'agreement among raft nodes before linearized reading'  (duration: 230.653509ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:15.816168Z","caller":"traceutil/trace.go:171","msg":"trace[815819215] transaction","detail":"{read_only:false; response_revision:25475; number_of_response:1; }","duration":"214.822718ms","start":"2026-06-06T17:53:15.601326Z","end":"2026-06-06T17:53:15.816149Z","steps":["trace[815819215] 'process raft request'  (duration: 129.284531ms)","trace[815819215] 'compare'  (duration: 85.441414ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:53:15.886654Z","caller":"traceutil/trace.go:171","msg":"trace[1906198052] transaction","detail":"{read_only:false; response_revision:25480; number_of_response:1; }","duration":"157.142844ms","start":"2026-06-06T17:53:15.729452Z","end":"2026-06-06T17:53:15.886595Z","steps":["trace[1906198052] 'process raft request'  (duration: 157.043642ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:15.886946Z","caller":"traceutil/trace.go:171","msg":"trace[1352875075] transaction","detail":"{read_only:false; response_revision:25477; number_of_response:1; }","duration":"285.150656ms","start":"2026-06-06T17:53:15.601782Z","end":"2026-06-06T17:53:15.886933Z","steps":["trace[1352875075] 'process raft request'  (duration: 284.520741ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:15.886986Z","caller":"traceutil/trace.go:171","msg":"trace[1783916428] transaction","detail":"{read_only:false; response_revision:25478; number_of_response:1; }","duration":"285.152676ms","start":"2026-06-06T17:53:15.601805Z","end":"2026-06-06T17:53:15.886958Z","steps":["trace[1783916428] 'process raft request'  (duration: 284.575232ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:15.887048Z","caller":"traceutil/trace.go:171","msg":"trace[327353953] transaction","detail":"{read_only:false; response_revision:25476; number_of_response:1; }","duration":"285.417992ms","start":"2026-06-06T17:53:15.601623Z","end":"2026-06-06T17:53:15.887041Z","steps":["trace[327353953] 'process raft request'  (duration: 284.48915ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:15.887046Z","caller":"traceutil/trace.go:171","msg":"trace[71577] transaction","detail":"{read_only:false; response_revision:25479; number_of_response:1; }","duration":"284.374498ms","start":"2026-06-06T17:53:15.602649Z","end":"2026-06-06T17:53:15.887024Z","steps":["trace[71577] 'process raft request'  (duration: 283.775733ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:16.111752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.045024ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531497329 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25467 > 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-06-06T17:53:16.111899Z","caller":"traceutil/trace.go:171","msg":"trace[753364010] linearizableReadLoop","detail":"{readStateIndex:26315; appliedIndex:26309; }","duration":"344.375936ms","start":"2026-06-06T17:53:15.767513Z","end":"2026-06-06T17:53:16.111889Z","steps":["trace[753364010] 'read index received'  (duration: 118.355528ms)","trace[753364010] 'applied index is now lower than readState.Index'  (duration: 226.019718ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:16.11206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.5358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-06T17:53:16.112091Z","caller":"traceutil/trace.go:171","msg":"trace[2052607563] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:25482; }","duration":"344.610082ms","start":"2026-06-06T17:53:15.76747Z","end":"2026-06-06T17:53:16.11208Z","steps":["trace[2052607563] 'agreement among raft nodes before linearized reading'  (duration: 344.5493ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:16.112113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:15.767452Z","time spent":"344.654502ms","remote":"127.0.0.1:40382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true "}
{"level":"info","ts":"2026-06-06T17:53:16.11212Z","caller":"traceutil/trace.go:171","msg":"trace[1736003716] transaction","detail":"{read_only:false; response_revision:25481; number_of_response:1; }","duration":"357.267496ms","start":"2026-06-06T17:53:15.75484Z","end":"2026-06-06T17:53:16.112108Z","steps":["trace[1736003716] 'process raft request'  (duration: 189.814743ms)","trace[1736003716] 'compare'  (duration: 166.789568ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:16.112359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:15.754814Z","time spent":"357.522713ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25467 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-06-06T17:53:16.112415Z","caller":"traceutil/trace.go:171","msg":"trace[1814105742] transaction","detail":"{read_only:false; response_revision:25482; number_of_response:1; }","duration":"302.633627ms","start":"2026-06-06T17:53:15.80976Z","end":"2026-06-06T17:53:16.112393Z","steps":["trace[1814105742] 'process raft request'  (duration: 302.080664ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:16.11255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:15.809717Z","time spent":"302.74495ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25468 > 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":"warn","ts":"2026-06-06T17:53:16.791532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.373016ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085745185531497344 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25470 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-06T17:53:16.791995Z","caller":"traceutil/trace.go:171","msg":"trace[1558002982] transaction","detail":"{read_only:false; response_revision:25486; number_of_response:1; }","duration":"322.500848ms","start":"2026-06-06T17:53:16.469462Z","end":"2026-06-06T17:53:16.791963Z","steps":["trace[1558002982] 'process raft request'  (duration: 322.271292ms)"],"step_count":1}
{"level":"info","ts":"2026-06-06T17:53:16.792014Z","caller":"traceutil/trace.go:171","msg":"trace[1455052797] transaction","detail":"{read_only:false; response_revision:25485; number_of_response:1; }","duration":"323.071521ms","start":"2026-06-06T17:53:16.468819Z","end":"2026-06-06T17:53:16.79189Z","steps":["trace[1455052797] 'process raft request'  (duration: 159.205733ms)","trace[1455052797] 'compare'  (duration: 163.086989ms)"],"step_count":2}
{"level":"info","ts":"2026-06-06T17:53:16.792112Z","caller":"traceutil/trace.go:171","msg":"trace[1637309495] transaction","detail":"{read_only:false; response_revision:25487; number_of_response:1; }","duration":"125.486341ms","start":"2026-06-06T17:53:16.666599Z","end":"2026-06-06T17:53:16.792085Z","steps":["trace[1637309495] 'process raft request'  (duration: 125.394868ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:16.792168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:16.469452Z","time spent":"322.62017ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25471 > 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-06-06T17:53:16.792201Z","caller":"traceutil/trace.go:171","msg":"trace[2116877533] linearizableReadLoop","detail":"{readStateIndex:26320; appliedIndex:26318; }","duration":"184.668729ms","start":"2026-06-06T17:53:16.60751Z","end":"2026-06-06T17:53:16.792179Z","steps":["trace[2116877533] 'read index received'  (duration: 20.468863ms)","trace[2116877533] 'applied index is now lower than readState.Index'  (duration: 164.197246ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-06T17:53:16.792354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.824163ms","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-06-06T17:53:16.792399Z","caller":"traceutil/trace.go:171","msg":"trace[2049317131] 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:25487; }","duration":"184.907055ms","start":"2026-06-06T17:53:16.60748Z","end":"2026-06-06T17:53:16.792387Z","steps":["trace[2049317131] 'agreement among raft nodes before linearized reading'  (duration: 184.814423ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:16.792569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.628843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-06-06T17:53:16.792644Z","caller":"traceutil/trace.go:171","msg":"trace[370626472] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:25487; }","duration":"137.799507ms","start":"2026-06-06T17:53:16.654827Z","end":"2026-06-06T17:53:16.792626Z","steps":["trace[370626472] 'agreement among raft nodes before linearized reading'  (duration: 137.495ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-06T17:53:16.792991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T17:53:16.468795Z","time spent":"323.299287ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25470 > 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-06-06T17:54:03.730412Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23010}
{"level":"info","ts":"2026-06-06T17:54:03.857359Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23010,"took":"123.664145ms","hash":1564583565,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":35491840,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-06-06T17:54:03.857435Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1564583565,"revision":23010,"compact-revision":20052}
{"level":"info","ts":"2026-06-06T17:54:33.489145Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000069dc.wal"}
{"level":"info","ts":"2026-06-06T17:59:03.737191Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26002}
{"level":"info","ts":"2026-06-06T17:59:03.877734Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26002,"took":"136.1962ms","hash":3760094905,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":34430976,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-06-06T17:59:03.877811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3760094905,"revision":26002,"compact-revision":23010}
{"level":"info","ts":"2026-06-06T17:59:53.67642Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2d372260bb4c37a","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-06T17:59:53.682154Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-06-06T17:59:53.68227Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-06-06T18:04:03.744829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28714}
{"level":"info","ts":"2026-06-06T18:04:03.883702Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28714,"took":"134.606623ms","hash":3804387982,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":30547968,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-06-06T18:04:03.883763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3804387982,"revision":28714,"compact-revision":26002}
{"level":"info","ts":"2026-06-06T18:09:03.750648Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30997}
{"level":"info","ts":"2026-06-06T18:09:03.888287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30997,"took":"133.753984ms","hash":4061492349,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":30482432,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-06-06T18:09:03.888356Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4061492349,"revision":30997,"compact-revision":28714}
{"level":"info","ts":"2026-06-06T18:14:03.763829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33297}
{"level":"info","ts":"2026-06-06T18:14:03.905657Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33297,"took":"138.123221ms","hash":1592584688,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":31817728,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-06T18:14:03.905716Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1592584688,"revision":33297,"compact-revision":30997}
{"level":"info","ts":"2026-06-06T18:19:03.774189Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35588}
{"level":"info","ts":"2026-06-06T18:19:03.921298Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35588,"took":"142.723142ms","hash":3894156238,"current-db-size-bytes":60428288,"current-db-size":"60 MB","current-db-size-in-use-bytes":31559680,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-06T18:19:03.921376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3894156238,"revision":35588,"compact-revision":33297}
{"level":"info","ts":"2026-06-06T18:21:06.340345Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2d372260bb4c37a","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-06T18:21:06.346396Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-06-06T18:21:06.346477Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-06-06T18:24:03.782496Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37822}
{"level":"info","ts":"2026-06-06T18:24:03.901065Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37822,"took":"114.226714ms","hash":1352994508,"current-db-size-bytes":60428288,"current-db-size":"60 MB","current-db-size-in-use-bytes":31408128,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-06T18:24:03.901135Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1352994508,"revision":37822,"compact-revision":35588}