{"level":"warn","ts":"2026-05-30T05:17:23.83582Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-30T05:17:23.835916Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-30T05:17:23.835984Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-30T05:17:23.835999Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-30T05:17:23.836022Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-30T05:17:23.83788Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]}
{"level":"info","ts":"2026-05-30T05:17:23.838117Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-30T05:17:23.842525Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.090158ms"}
{"level":"info","ts":"2026-05-30T05:17:23.848078Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"}
{"level":"info","ts":"2026-05-30T05:17:23.848163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-30T05:17:23.848189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"}
{"level":"info","ts":"2026-05-30T05:17:23.848207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-30T05:17:23.848222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"}
{"level":"info","ts":"2026-05-30T05:17:23.848313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"warn","ts":"2026-05-30T05:17:23.855814Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-30T05:17:23.859656Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-30T05:17:23.861428Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-30T05:17:23.863684Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-30T05:17:23.863813Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-30T05:17:23.863896Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-30T05:17:23.864135Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-30T05:17:23.864181Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-30T05:17:23.864704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"info","ts":"2026-05-30T05:17:23.864841Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-30T05:17:23.866394Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-30T05:17:23.8665Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-30T05:17:23.86661Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-30T05:17:23.866774Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-30T05:17:23.866813Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-30T05:17:24.449025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-30T05:17:24.449092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-30T05:17:24.44914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"}
{"level":"info","ts":"2026-05-30T05:17:24.449155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"}
{"level":"info","ts":"2026-05-30T05:17:24.449164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-30T05:17:24.449173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"}
{"level":"info","ts":"2026-05-30T05:17:24.449182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-30T05:17:24.450106Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-30T05:17:24.450146Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-30T05:17:24.450111Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-30T05:17:24.450139Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-30T05:17:24.450423Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-30T05:17:24.450476Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-30T05:17:24.451527Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-30T05:17:24.451637Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-30T05:17:24.451675Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-30T05:17:24.45278Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"}
{"level":"info","ts":"2026-05-30T05:17:24.453201Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-30T05:18:07.515613Z","caller":"traceutil/trace.go:171","msg":"trace[154844135] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"125.556061ms","start":"2026-05-30T05:18:07.39002Z","end":"2026-05-30T05:18:07.515576Z","steps":["trace[154844135] 'process raft request'  (duration: 125.357537ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:18:07.592277Z","caller":"traceutil/trace.go:171","msg":"trace[1764135321] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"106.350668ms","start":"2026-05-30T05:18:07.485881Z","end":"2026-05-30T05:18:07.592231Z","steps":["trace[1764135321] 'process raft request'  (duration: 105.486822ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:18:07.842746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.08061ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777612586 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:38c19e7750ca0d29>","response":"size:41"}
{"level":"info","ts":"2026-05-30T05:18:07.842901Z","caller":"traceutil/trace.go:171","msg":"trace[598028878] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"187.139493ms","start":"2026-05-30T05:18:07.655739Z","end":"2026-05-30T05:18:07.842878Z","steps":["trace[598028878] 'read index received'  (duration: 42.805378ms)","trace[598028878] 'applied index is now lower than readState.Index'  (duration: 144.332245ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:18:07.843128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.382717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:18:07.843158Z","caller":"traceutil/trace.go:171","msg":"trace[783355322] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:582; }","duration":"187.48827ms","start":"2026-05-30T05:18:07.65566Z","end":"2026-05-30T05:18:07.843148Z","steps":["trace[783355322] 'agreement among raft nodes before linearized reading'  (duration: 187.407789ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:18:08.382353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.716545ms","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-05-30T05:18:08.382465Z","caller":"traceutil/trace.go:171","msg":"trace[145478803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"161.365786ms","start":"2026-05-30T05:18:08.221072Z","end":"2026-05-30T05:18:08.382438Z","steps":["trace[145478803] 'range keys from in-memory index tree'  (duration: 159.43574ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:18:08.38264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.314809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-30T05:18:08.382745Z","caller":"traceutil/trace.go:171","msg":"trace[1947660641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"157.458752ms","start":"2026-05-30T05:18:08.225259Z","end":"2026-05-30T05:18:08.382718Z","steps":["trace[1947660641] 'range keys from in-memory index tree'  (duration: 155.546426ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:18:08.388715Z","caller":"traceutil/trace.go:171","msg":"trace[336309294] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"149.002533ms","start":"2026-05-30T05:18:08.239685Z","end":"2026-05-30T05:18:08.388688Z","steps":["trace[336309294] 'process raft request'  (duration: 142.361018ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:18:23.852237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.827222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-30T05:18:23.852376Z","caller":"traceutil/trace.go:171","msg":"trace[1925305731] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:759; }","duration":"183.034256ms","start":"2026-05-30T05:18:23.669319Z","end":"2026-05-30T05:18:23.852353Z","steps":["trace[1925305731] 'range keys from in-memory index tree'  (duration: 182.602408ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:19:42.301342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.44023ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777615036 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-kq4wq\" mod_revision:1796 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-kq4wq\" value_size:1458 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-kq4wq\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-30T05:19:42.301492Z","caller":"traceutil/trace.go:171","msg":"trace[193623582] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"303.792888ms","start":"2026-05-30T05:19:41.997676Z","end":"2026-05-30T05:19:42.301469Z","steps":["trace[193623582] 'process raft request'  (duration: 44.618023ms)","trace[193623582] 'compare'  (duration: 257.789358ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:19:42.301563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:41.997662Z","time spent":"303.86899ms","remote":"127.0.0.1:45204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-kq4wq\" mod_revision:1796 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-kq4wq\" value_size:1458 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-kq4wq\" > >"}
{"level":"info","ts":"2026-05-30T05:19:42.348761Z","caller":"traceutil/trace.go:171","msg":"trace[976919422] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"350.499261ms","start":"2026-05-30T05:19:41.998229Z","end":"2026-05-30T05:19:42.348729Z","steps":["trace[976919422] 'process raft request'  (duration: 350.4508ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:19:42.348753Z","caller":"traceutil/trace.go:171","msg":"trace[847358905] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"350.640964ms","start":"2026-05-30T05:19:41.998064Z","end":"2026-05-30T05:19:42.348705Z","steps":["trace[847358905] 'process raft request'  (duration: 350.46864ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:19:42.348852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:41.998188Z","time spent":"350.621723ms","remote":"127.0.0.1:46822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy-replicas\" mod_revision:1800 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy-replicas\" value_size:815 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy-replicas\" > >"}
{"level":"info","ts":"2026-05-30T05:19:42.348845Z","caller":"traceutil/trace.go:171","msg":"trace[506201714] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"350.672384ms","start":"2026-05-30T05:19:41.998117Z","end":"2026-05-30T05:19:42.348789Z","steps":["trace[506201714] 'process raft request'  (duration: 350.521811ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:19:42.349075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:41.998041Z","time spent":"350.815957ms","remote":"127.0.0.1:46822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" mod_revision:1797 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" value_size:908 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" > >"}
{"level":"warn","ts":"2026-05-30T05:19:42.349205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:41.998041Z","time spent":"351.017412ms","remote":"127.0.0.1:45204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-jkr4z\" mod_revision:1801 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-jkr4z\" value_size:1391 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-jkr4z\" > >"}
{"level":"info","ts":"2026-05-30T05:19:42.3822Z","caller":"traceutil/trace.go:171","msg":"trace[1252935059] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"302.603865ms","start":"2026-05-30T05:19:42.079547Z","end":"2026-05-30T05:19:42.382151Z","steps":["trace[1252935059] 'process raft request'  (duration: 302.363571ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:19:42.382438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:42.079513Z","time spent":"302.801929ms","remote":"127.0.0.1:45190","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:1802 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-30T05:20:31.578082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.355775ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777615795 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2135 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-30T05:20:31.578445Z","caller":"traceutil/trace.go:171","msg":"trace[436362623] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2227; }","duration":"256.797105ms","start":"2026-05-30T05:20:31.321621Z","end":"2026-05-30T05:20:31.578418Z","steps":["trace[436362623] 'read index received'  (duration: 14.064763ms)","trace[436362623] 'applied index is now lower than readState.Index'  (duration: 242.730271ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:20:31.578563Z","caller":"traceutil/trace.go:171","msg":"trace[711732207] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"298.834241ms","start":"2026-05-30T05:20:31.279673Z","end":"2026-05-30T05:20:31.578508Z","steps":["trace[711732207] 'process raft request'  (duration: 298.605167ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:20:31.578678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.02789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-30T05:20:31.578775Z","caller":"traceutil/trace.go:171","msg":"trace[961546303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2149; }","duration":"257.175952ms","start":"2026-05-30T05:20:31.321579Z","end":"2026-05-30T05:20:31.578755Z","steps":["trace[961546303] 'agreement among raft nodes before linearized reading'  (duration: 256.920437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:20:31.578548Z","caller":"traceutil/trace.go:171","msg":"trace[870103346] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"368.898823ms","start":"2026-05-30T05:20:31.2096Z","end":"2026-05-30T05:20:31.578499Z","steps":["trace[870103346] 'process raft request'  (duration: 125.982878ms)","trace[870103346] 'compare'  (duration: 242.126751ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:20:31.579035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:31.209577Z","time spent":"369.254889ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2135 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-30T05:20:31.634218Z","caller":"traceutil/trace.go:171","msg":"trace[781066700] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"270.575594ms","start":"2026-05-30T05:20:31.36362Z","end":"2026-05-30T05:20:31.634195Z","steps":["trace[781066700] 'process raft request'  (duration: 270.448961ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:20:31.634319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.396328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:20:31.634536Z","caller":"traceutil/trace.go:171","msg":"trace[1296008257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2150; }","duration":"178.685494ms","start":"2026-05-30T05:20:31.455834Z","end":"2026-05-30T05:20:31.63452Z","steps":["trace[1296008257] 'agreement among raft nodes before linearized reading'  (duration: 178.376869ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:21:47.416261Z","caller":"traceutil/trace.go:171","msg":"trace[340123436] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"104.675018ms","start":"2026-05-30T05:21:47.311558Z","end":"2026-05-30T05:21:47.416233Z","steps":["trace[340123436] 'process raft request'  (duration: 104.320001ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:21:47.629425Z","caller":"traceutil/trace.go:171","msg":"trace[2089068409] linearizableReadLoop","detail":"{readStateIndex:2860; appliedIndex:2859; }","duration":"174.889859ms","start":"2026-05-30T05:21:47.454497Z","end":"2026-05-30T05:21:47.629387Z","steps":["trace[2089068409] 'read index received'  (duration: 132.92ms)","trace[2089068409] 'applied index is now lower than readState.Index'  (duration: 41.968739ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:21:47.62944Z","caller":"traceutil/trace.go:171","msg":"trace[1202115214] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"207.625183ms","start":"2026-05-30T05:21:47.421778Z","end":"2026-05-30T05:21:47.629403Z","steps":["trace[1202115214] 'process raft request'  (duration: 165.713515ms)","trace[1202115214] 'compare'  (duration: 41.773426ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:21:47.629706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.178584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:21:47.629837Z","caller":"traceutil/trace.go:171","msg":"trace[1341127992] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2756; }","duration":"175.332097ms","start":"2026-05-30T05:21:47.454479Z","end":"2026-05-30T05:21:47.629811Z","steps":["trace[1341127992] 'agreement among raft nodes before linearized reading'  (duration: 175.030451ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:25:46.421236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.056033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-30T05:25:46.421358Z","caller":"traceutil/trace.go:171","msg":"trace[176756285] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:4937; }","duration":"166.256437ms","start":"2026-05-30T05:25:46.255078Z","end":"2026-05-30T05:25:46.421334Z","steps":["trace[176756285] 'count revisions from in-memory index tree'  (duration: 165.86915ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:25:46.421632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.316421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-30T05:25:46.421653Z","caller":"traceutil/trace.go:171","msg":"trace[2006986365] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4937; }","duration":"236.390042ms","start":"2026-05-30T05:25:46.185255Z","end":"2026-05-30T05:25:46.421645Z","steps":["trace[2006986365] 'count revisions from in-memory index tree'  (duration: 236.218879ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:26:01.204393Z","caller":"traceutil/trace.go:171","msg":"trace[463353432] linearizableReadLoop","detail":"{readStateIndex:5423; appliedIndex:5422; }","duration":"219.341093ms","start":"2026-05-30T05:26:00.985025Z","end":"2026-05-30T05:26:01.204366Z","steps":["trace[463353432] 'read index received'  (duration: 219.119509ms)","trace[463353432] 'applied index is now lower than readState.Index'  (duration: 220.543µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:26:01.204459Z","caller":"traceutil/trace.go:171","msg":"trace[300883183] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"290.457286ms","start":"2026-05-30T05:26:00.913952Z","end":"2026-05-30T05:26:01.20441Z","steps":["trace[300883183] 'process raft request'  (duration: 290.254673ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:26:01.204651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.116179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-30T05:26:01.204681Z","caller":"traceutil/trace.go:171","msg":"trace[1969538797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5227; }","duration":"219.21286ms","start":"2026-05-30T05:26:00.98546Z","end":"2026-05-30T05:26:01.204673Z","steps":["trace[1969538797] 'agreement among raft nodes before linearized reading'  (duration: 219.063357ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:26:01.204764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.695739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-30T05:26:01.204868Z","caller":"traceutil/trace.go:171","msg":"trace[250926525] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5227; }","duration":"219.950654ms","start":"2026-05-30T05:26:00.984895Z","end":"2026-05-30T05:26:01.204845Z","steps":["trace[250926525] 'agreement among raft nodes before linearized reading'  (duration: 219.594008ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:26:08.441895Z","caller":"traceutil/trace.go:171","msg":"trace[2063436872] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"167.678734ms","start":"2026-05-30T05:26:08.274167Z","end":"2026-05-30T05:26:08.441846Z","steps":["trace[2063436872] 'process raft request'  (duration: 136.441238ms)","trace[2063436872] 'compare'  (duration: 31.095533ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:26:08.701817Z","caller":"traceutil/trace.go:171","msg":"trace[1617201497] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"197.025734ms","start":"2026-05-30T05:26:08.504738Z","end":"2026-05-30T05:26:08.701763Z","steps":["trace[1617201497] 'process raft request'  (duration: 146.774012ms)","trace[1617201497] 'compare'  (duration: 49.927135ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:26:08.702413Z","caller":"traceutil/trace.go:171","msg":"trace[976059782] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"197.246948ms","start":"2026-05-30T05:26:08.505123Z","end":"2026-05-30T05:26:08.70237Z","steps":["trace[976059782] 'process raft request'  (duration: 196.456053ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:26:18.614633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.435673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2aa4f7f1-8cb2-411a-8fef-a86be7663788\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-30T05:26:18.61476Z","caller":"traceutil/trace.go:171","msg":"trace[641522889] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2aa4f7f1-8cb2-411a-8fef-a86be7663788; range_end:; response_count:1; response_revision:5523; }","duration":"107.606248ms","start":"2026-05-30T05:26:18.507126Z","end":"2026-05-30T05:26:18.614732Z","steps":["trace[641522889] 'range keys from in-memory index tree'  (duration: 107.192409ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:27:24.477907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2960}
{"level":"info","ts":"2026-05-30T05:27:24.558424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2960,"took":"78.299618ms","hash":3043828131,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":34246656,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-30T05:27:24.558581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3043828131,"revision":2960,"compact-revision":-1}
{"level":"info","ts":"2026-05-30T05:32:09.093256Z","caller":"traceutil/trace.go:171","msg":"trace[1361856892] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"168.694418ms","start":"2026-05-30T05:32:08.924532Z","end":"2026-05-30T05:32:09.093226Z","steps":["trace[1361856892] 'process raft request'  (duration: 168.513324ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:32:21.631867Z","caller":"traceutil/trace.go:171","msg":"trace[171637542] transaction","detail":"{read_only:false; response_revision:8238; number_of_response:1; }","duration":"119.726058ms","start":"2026-05-30T05:32:21.512117Z","end":"2026-05-30T05:32:21.631843Z","steps":["trace[171637542] 'process raft request'  (duration: 71.095675ms)","trace[171637542] 'compare'  (duration: 48.508431ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:32:21.660041Z","caller":"traceutil/trace.go:171","msg":"trace[1303821729] transaction","detail":"{read_only:false; response_revision:8239; number_of_response:1; }","duration":"147.53515ms","start":"2026-05-30T05:32:21.512478Z","end":"2026-05-30T05:32:21.660013Z","steps":["trace[1303821729] 'process raft request'  (duration: 147.283686ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:32:21.660366Z","caller":"traceutil/trace.go:171","msg":"trace[170606055] transaction","detail":"{read_only:false; response_revision:8240; number_of_response:1; }","duration":"147.651262ms","start":"2026-05-30T05:32:21.512688Z","end":"2026-05-30T05:32:21.660339Z","steps":["trace[170606055] 'process raft request'  (duration: 147.256875ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:32:21.660406Z","caller":"traceutil/trace.go:171","msg":"trace[1522405704] transaction","detail":"{read_only:false; response_revision:8242; number_of_response:1; }","duration":"147.588761ms","start":"2026-05-30T05:32:21.512791Z","end":"2026-05-30T05:32:21.66038Z","steps":["trace[1522405704] 'process raft request'  (duration: 147.53443ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:32:21.660433Z","caller":"traceutil/trace.go:171","msg":"trace[556786074] transaction","detail":"{read_only:false; response_revision:8241; number_of_response:1; }","duration":"147.643702ms","start":"2026-05-30T05:32:21.512763Z","end":"2026-05-30T05:32:21.660406Z","steps":["trace[556786074] 'process raft request'  (duration: 147.451489ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:32:22.441681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.112783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-f2hxr\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-05-30T05:32:22.441784Z","caller":"traceutil/trace.go:171","msg":"trace[732113377] range","detail":"{range_begin:/registry/pods/openstack/keepalived-f2hxr; range_end:; response_count:1; response_revision:8243; }","duration":"219.284417ms","start":"2026-05-30T05:32:22.222479Z","end":"2026-05-30T05:32:22.441763Z","steps":["trace[732113377] 'range keys from in-memory index tree'  (duration: 218.91161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:32:22.442035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.163928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"}
{"level":"info","ts":"2026-05-30T05:32:22.442171Z","caller":"traceutil/trace.go:171","msg":"trace[1752252136] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8243; }","duration":"200.331952ms","start":"2026-05-30T05:32:22.241805Z","end":"2026-05-30T05:32:22.442137Z","steps":["trace[1752252136] 'range keys from in-memory index tree'  (duration: 199.932503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:32:23.750895Z","caller":"traceutil/trace.go:171","msg":"trace[1564508003] transaction","detail":"{read_only:false; response_revision:8251; number_of_response:1; }","duration":"109.537826ms","start":"2026-05-30T05:32:23.641307Z","end":"2026-05-30T05:32:23.750845Z","steps":["trace[1564508003] 'process raft request'  (duration: 109.070698ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:32:24.484138Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6070}
{"level":"info","ts":"2026-05-30T05:32:24.583999Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6070,"took":"96.862709ms","hash":4121812814,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":23236608,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-30T05:32:24.584082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4121812814,"revision":6070,"compact-revision":2960}
{"level":"info","ts":"2026-05-30T05:32:50.739384Z","caller":"traceutil/trace.go:171","msg":"trace[1517941969] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"143.007575ms","start":"2026-05-30T05:32:50.596333Z","end":"2026-05-30T05:32:50.73934Z","steps":["trace[1517941969] 'process raft request'  (duration: 142.655849ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:33:03.681933Z","caller":"traceutil/trace.go:171","msg":"trace[485924671] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"239.247674ms","start":"2026-05-30T05:33:03.442593Z","end":"2026-05-30T05:33:03.681841Z","steps":["trace[485924671] 'process raft request'  (duration: 239.006569ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:33:03.923154Z","caller":"traceutil/trace.go:171","msg":"trace[1467243087] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"174.589092ms","start":"2026-05-30T05:33:03.748518Z","end":"2026-05-30T05:33:03.923107Z","steps":["trace[1467243087] 'process raft request'  (duration: 162.911881ms)","trace[1467243087] 'compare'  (duration: 11.200032ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:33:04.080169Z","caller":"traceutil/trace.go:171","msg":"trace[695869336] linearizableReadLoop","detail":"{readStateIndex:8870; appliedIndex:8869; }","duration":"105.747949ms","start":"2026-05-30T05:33:03.97439Z","end":"2026-05-30T05:33:04.080138Z","steps":["trace[695869336] 'read index received'  (duration: 64.725353ms)","trace[695869336] 'applied index is now lower than readState.Index'  (duration: 41.021266ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:33:04.080216Z","caller":"traceutil/trace.go:171","msg":"trace[694636076] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"247.056321ms","start":"2026-05-30T05:33:03.833118Z","end":"2026-05-30T05:33:04.080175Z","steps":["trace[694636076] 'process raft request'  (duration: 205.995105ms)","trace[694636076] 'compare'  (duration: 40.890623ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:33:04.080477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.062855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-30T05:33:04.080516Z","caller":"traceutil/trace.go:171","msg":"trace[1048941919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8564; }","duration":"106.187817ms","start":"2026-05-30T05:33:03.974319Z","end":"2026-05-30T05:33:04.080506Z","steps":["trace[1048941919] 'agreement among raft nodes before linearized reading'  (duration: 106.004094ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:33:04.080607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.895562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-30T05:33:04.080668Z","caller":"traceutil/trace.go:171","msg":"trace[1275962118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8564; }","duration":"105.956644ms","start":"2026-05-30T05:33:03.974694Z","end":"2026-05-30T05:33:04.08065Z","steps":["trace[1275962118] 'agreement among raft nodes before linearized reading'  (duration: 105.80807ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:33:04.664133Z","caller":"traceutil/trace.go:171","msg":"trace[1528824676] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"158.518377ms","start":"2026-05-30T05:33:04.505581Z","end":"2026-05-30T05:33:04.664099Z","steps":["trace[1528824676] 'process raft request'  (duration: 158.246432ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:33:04.81563Z","caller":"traceutil/trace.go:171","msg":"trace[547253218] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"136.761655ms","start":"2026-05-30T05:33:04.678839Z","end":"2026-05-30T05:33:04.815601Z","steps":["trace[547253218] 'process raft request'  (duration: 106.516354ms)","trace[547253218] 'compare'  (duration: 30.041498ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:33:20.334744Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000236e.wal"}
{"level":"info","ts":"2026-05-30T05:34:18.698043Z","caller":"traceutil/trace.go:171","msg":"trace[638041658] transaction","detail":"{read_only:false; response_revision:9301; number_of_response:1; }","duration":"133.900782ms","start":"2026-05-30T05:34:18.564102Z","end":"2026-05-30T05:34:18.698003Z","steps":["trace[638041658] 'process raft request'  (duration: 59.044196ms)","trace[638041658] 'compare'  (duration: 74.651252ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:34:18.698326Z","caller":"traceutil/trace.go:171","msg":"trace[1944241479] transaction","detail":"{read_only:false; response_revision:9302; number_of_response:1; }","duration":"133.547166ms","start":"2026-05-30T05:34:18.56472Z","end":"2026-05-30T05:34:18.698267Z","steps":["trace[1944241479] 'process raft request'  (duration: 133.240571ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:35:09.449915Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-30T05:35:09.45807Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-30T05:35:09.458243Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-30T05:37:24.492359Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8261}
{"level":"info","ts":"2026-05-30T05:37:24.574433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8261,"took":"79.214759ms","hash":3118828805,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":25284608,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-30T05:37:24.574633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3118828805,"revision":8261,"compact-revision":6070}
{"level":"info","ts":"2026-05-30T05:42:24.500397Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10741}
{"level":"info","ts":"2026-05-30T05:42:24.591789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10741,"took":"88.224376ms","hash":1782559908,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":27656192,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-30T05:42:24.591869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1782559908,"revision":10741,"compact-revision":8261}
{"level":"warn","ts":"2026-05-30T05:44:35.54072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313096208777646879,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-30T05:44:35.554134Z","caller":"traceutil/trace.go:171","msg":"trace[1810377433] linearizableReadLoop","detail":"{readStateIndex:14258; appliedIndex:14257; }","duration":"514.250437ms","start":"2026-05-30T05:44:35.039844Z","end":"2026-05-30T05:44:35.554095Z","steps":["trace[1810377433] 'read index received'  (duration: 513.980272ms)","trace[1810377433] 'applied index is now lower than readState.Index'  (duration: 268.495µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:44:35.554239Z","caller":"traceutil/trace.go:171","msg":"trace[2041253165] transaction","detail":"{read_only:false; response_revision:13784; number_of_response:1; }","duration":"707.978467ms","start":"2026-05-30T05:44:34.846217Z","end":"2026-05-30T05:44:35.554196Z","steps":["trace[2041253165] 'process raft request'  (duration: 707.531508ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:44:35.554394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:44:34.846183Z","time spent":"708.109419ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:13770 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-30T05:44:35.554422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.541022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-30T05:44:35.554467Z","caller":"traceutil/trace.go:171","msg":"trace[2113255029] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:13784; }","duration":"514.687974ms","start":"2026-05-30T05:44:35.039765Z","end":"2026-05-30T05:44:35.554453Z","steps":["trace[2113255029] 'agreement among raft nodes before linearized reading'  (duration: 514.533911ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:44:35.554513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:44:35.039733Z","time spent":"514.767966ms","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":17,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "}
{"level":"warn","ts":"2026-05-30T05:44:35.554675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.686903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-30T05:44:35.554792Z","caller":"traceutil/trace.go:171","msg":"trace[234703490] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:13784; }","duration":"263.859826ms","start":"2026-05-30T05:44:35.290906Z","end":"2026-05-30T05:44:35.554766Z","steps":["trace[234703490] 'agreement among raft nodes before linearized reading'  (duration: 263.620661ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.665636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313096208777650166,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-30T05:46:06.832289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.531467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-05-30T05:46:06.832408Z","caller":"traceutil/trace.go:171","msg":"trace[503688790] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14807; }","duration":"703.668299ms","start":"2026-05-30T05:46:06.128717Z","end":"2026-05-30T05:46:06.832385Z","steps":["trace[503688790] 'range keys from in-memory index tree'  (duration: 703.270922ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.832454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.128642Z","time spent":"703.802662ms","remote":"127.0.0.1:46908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5547,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-05-30T05:46:06.832622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.334731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:46:06.832751Z","caller":"traceutil/trace.go:171","msg":"trace[350435933] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14807; }","duration":"705.505204ms","start":"2026-05-30T05:46:06.127214Z","end":"2026-05-30T05:46:06.832719Z","steps":["trace[350435933] 'range keys from in-memory index tree'  (duration: 705.169418ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.832813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.1272Z","time spent":"705.601736ms","remote":"127.0.0.1:46908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-05-30T05:46:06.832898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.742083ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777650167 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14797 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-30T05:46:06.833331Z","caller":"traceutil/trace.go:171","msg":"trace[305434568] linearizableReadLoop","detail":"{readStateIndex:15315; appliedIndex:15314; }","duration":"667.71947ms","start":"2026-05-30T05:46:06.165588Z","end":"2026-05-30T05:46:06.833308Z","steps":["trace[305434568] 'read index received'  (duration: 520.262104ms)","trace[305434568] 'applied index is now lower than readState.Index'  (duration: 147.455136ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:46:06.833371Z","caller":"traceutil/trace.go:171","msg":"trace[299632823] transaction","detail":"{read_only:false; response_revision:14808; number_of_response:1; }","duration":"687.455912ms","start":"2026-05-30T05:46:06.145868Z","end":"2026-05-30T05:46:06.833324Z","steps":["trace[299632823] 'process raft request'  (duration: 540.170889ms)","trace[299632823] 'compare'  (duration: 146.003609ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:46:06.833518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.833024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:46:06.833557Z","caller":"traceutil/trace.go:171","msg":"trace[416931099] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14808; }","duration":"574.899255ms","start":"2026-05-30T05:46:06.258643Z","end":"2026-05-30T05:46:06.833542Z","steps":["trace[416931099] 'agreement among raft nodes before linearized reading'  (duration: 574.815583ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.833593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.25863Z","time spent":"574.953557ms","remote":"127.0.0.1:46908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "}
{"level":"warn","ts":"2026-05-30T05:46:06.833594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.134416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-30T05:46:06.833604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.145842Z","time spent":"687.653447ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14797 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-30T05:46:06.833583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.967335ms","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":"warn","ts":"2026-05-30T05:46:06.833616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.503673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-30T05:46:06.833685Z","caller":"traceutil/trace.go:171","msg":"trace[711483729] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14808; }","duration":"668.098647ms","start":"2026-05-30T05:46:06.16556Z","end":"2026-05-30T05:46:06.833659Z","steps":["trace[711483729] 'agreement among raft nodes before linearized reading'  (duration: 667.849442ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:06.833716Z","caller":"traceutil/trace.go:171","msg":"trace[277811353] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14808; }","duration":"298.665605ms","start":"2026-05-30T05:46:06.535029Z","end":"2026-05-30T05:46:06.833694Z","steps":["trace[277811353] 'agreement among raft nodes before linearized reading'  (duration: 298.462701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.833733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.869801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-30T05:46:06.833754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.165548Z","time spent":"668.189519ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-30T05:46:06.833767Z","caller":"traceutil/trace.go:171","msg":"trace[1304516111] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14808; }","duration":"106.936541ms","start":"2026-05-30T05:46:06.726821Z","end":"2026-05-30T05:46:06.833758Z","steps":["trace[1304516111] 'agreement among raft nodes before linearized reading'  (duration: 106.86847ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:06.833664Z","caller":"traceutil/trace.go:171","msg":"trace[1672491078] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14808; }","duration":"107.268098ms","start":"2026-05-30T05:46:06.726374Z","end":"2026-05-30T05:46:06.833642Z","steps":["trace[1672491078] 'agreement among raft nodes before linearized reading'  (duration: 107.123455ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.833964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.161977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-30T05:46:06.834015Z","caller":"traceutil/trace.go:171","msg":"trace[961994621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14808; }","duration":"360.246889ms","start":"2026-05-30T05:46:06.473758Z","end":"2026-05-30T05:46:06.834005Z","steps":["trace[961994621] 'agreement among raft nodes before linearized reading'  (duration: 360.096346ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.313338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-05-30T05:46:06.834121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.473747Z","time spent":"360.30446ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-30T05:46:06.834137Z","caller":"traceutil/trace.go:171","msg":"trace[1301569976] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14808; }","duration":"107.36856ms","start":"2026-05-30T05:46:06.726757Z","end":"2026-05-30T05:46:06.834126Z","steps":["trace[1301569976] 'agreement among raft nodes before linearized reading'  (duration: 107.178946ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.810275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-05-30T05:46:06.834234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.248002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:46:06.834262Z","caller":"traceutil/trace.go:171","msg":"trace[29505676] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14808; }","duration":"575.274332ms","start":"2026-05-30T05:46:06.258979Z","end":"2026-05-30T05:46:06.834253Z","steps":["trace[29505676] 'agreement among raft nodes before linearized reading'  (duration: 575.229711ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.801337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-30T05:46:06.834387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.581389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-30T05:46:06.834002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.469056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-30T05:46:06.834404Z","caller":"traceutil/trace.go:171","msg":"trace[508480044] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14808; }","duration":"108.046082ms","start":"2026-05-30T05:46:06.726344Z","end":"2026-05-30T05:46:06.83439Z","steps":["trace[508480044] 'agreement among raft nodes before linearized reading'  (duration: 107.884209ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:06.834414Z","caller":"traceutil/trace.go:171","msg":"trace[708978729] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14808; }","duration":"575.66879ms","start":"2026-05-30T05:46:06.258737Z","end":"2026-05-30T05:46:06.834406Z","steps":["trace[708978729] 'agreement among raft nodes before linearized reading'  (duration: 575.579398ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.387101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-05-30T05:46:06.834298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.258945Z","time spent":"575.347294ms","remote":"127.0.0.1:46908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "}
{"level":"info","ts":"2026-05-30T05:46:06.834273Z","caller":"traceutil/trace.go:171","msg":"trace[883414690] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14808; }","duration":"109.901287ms","start":"2026-05-30T05:46:06.724344Z","end":"2026-05-30T05:46:06.834245Z","steps":["trace[883414690] 'agreement among raft nodes before linearized reading'  (duration: 109.704593ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.89351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-05-30T05:46:06.834601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.786797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:46:06.83445Z","caller":"traceutil/trace.go:171","msg":"trace[786176078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14808; }","duration":"139.920854ms","start":"2026-05-30T05:46:06.694511Z","end":"2026-05-30T05:46:06.834432Z","steps":["trace[786176078] 'agreement among raft nodes before linearized reading'  (duration: 139.276753ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:06.834636Z","caller":"traceutil/trace.go:171","msg":"trace[547730850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14808; }","duration":"379.839068ms","start":"2026-05-30T05:46:06.454787Z","end":"2026-05-30T05:46:06.834626Z","steps":["trace[547730850] 'agreement among raft nodes before linearized reading'  (duration: 379.783007ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:06.834646Z","caller":"traceutil/trace.go:171","msg":"trace[1414775062] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14808; }","duration":"388.991862ms","start":"2026-05-30T05:46:06.445629Z","end":"2026-05-30T05:46:06.834621Z","steps":["trace[1414775062] 'agreement among raft nodes before linearized reading'  (duration: 388.783058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.2587Z","time spent":"575.753751ms","remote":"127.0.0.1:46908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-05-30T05:46:06.834672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.454772Z","time spent":"379.89342ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-30T05:46:06.83468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.445609Z","time spent":"389.063864ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-30T05:46:06.834663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.096036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-l7jqd\" ","response":"range_response_count:1 size:9798"}
{"level":"warn","ts":"2026-05-30T05:46:06.8347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.167033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-05-30T05:46:06.834744Z","caller":"traceutil/trace.go:171","msg":"trace[1942653869] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-l7jqd; range_end:; response_count:1; response_revision:14808; }","duration":"487.200368ms","start":"2026-05-30T05:46:06.347525Z","end":"2026-05-30T05:46:06.834725Z","steps":["trace[1942653869] 'agreement among raft nodes before linearized reading'  (duration: 486.988834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.834813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.347513Z","time spent":"487.284979ms","remote":"127.0.0.1:46834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9822,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-l7jqd\" "}
{"level":"info","ts":"2026-05-30T05:46:06.834518Z","caller":"traceutil/trace.go:171","msg":"trace[280405623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14808; }","duration":"151.521014ms","start":"2026-05-30T05:46:06.682979Z","end":"2026-05-30T05:46:06.8345Z","steps":["trace[280405623] 'agreement among raft nodes before linearized reading'  (duration: 151.33619ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:06.834755Z","caller":"traceutil/trace.go:171","msg":"trace[1129932588] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14808; }","duration":"572.279555ms","start":"2026-05-30T05:46:06.262463Z","end":"2026-05-30T05:46:06.834743Z","steps":["trace[1129932588] 'agreement among raft nodes before linearized reading'  (duration: 571.705215ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:06.835134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:46:06.262436Z","time spent":"572.671823ms","remote":"127.0.0.1:46908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5547,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-05-30T05:46:12.187084Z","caller":"traceutil/trace.go:171","msg":"trace[657230621] transaction","detail":"{read_only:false; response_revision:14836; number_of_response:1; }","duration":"178.625745ms","start":"2026-05-30T05:46:12.008431Z","end":"2026-05-30T05:46:12.187057Z","steps":["trace[657230621] 'process raft request'  (duration: 178.471833ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:12.193538Z","caller":"traceutil/trace.go:171","msg":"trace[1958156232] linearizableReadLoop","detail":"{readStateIndex:15345; appliedIndex:15343; }","duration":"126.392039ms","start":"2026-05-30T05:46:12.067131Z","end":"2026-05-30T05:46:12.193523Z","steps":["trace[1958156232] 'read index received'  (duration: 119.797384ms)","trace[1958156232] 'applied index is now lower than readState.Index'  (duration: 6.593435ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:46:12.193749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.600054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-05-30T05:46:12.193791Z","caller":"traceutil/trace.go:171","msg":"trace[616239044] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14837; }","duration":"126.704945ms","start":"2026-05-30T05:46:12.067076Z","end":"2026-05-30T05:46:12.193781Z","steps":["trace[616239044] 'agreement among raft nodes before linearized reading'  (duration: 126.552762ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:12.193788Z","caller":"traceutil/trace.go:171","msg":"trace[392896967] transaction","detail":"{read_only:false; response_revision:14837; number_of_response:1; }","duration":"148.304222ms","start":"2026-05-30T05:46:12.045356Z","end":"2026-05-30T05:46:12.19366Z","steps":["trace[392896967] 'process raft request'  (duration: 148.080668ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:12.193833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.50128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-05-30T05:46:12.193871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.170734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-30T05:46:12.19391Z","caller":"traceutil/trace.go:171","msg":"trace[352897485] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14837; }","duration":"126.599022ms","start":"2026-05-30T05:46:12.067297Z","end":"2026-05-30T05:46:12.193896Z","steps":["trace[352897485] 'agreement among raft nodes before linearized reading'  (duration: 126.474169ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:46:12.19393Z","caller":"traceutil/trace.go:171","msg":"trace[1056289283] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14837; }","duration":"126.269326ms","start":"2026-05-30T05:46:12.067644Z","end":"2026-05-30T05:46:12.193913Z","steps":["trace[1056289283] 'agreement among raft nodes before linearized reading'  (duration: 126.187385ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:46:12.193971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.222628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-30T05:46:12.194089Z","caller":"traceutil/trace.go:171","msg":"trace[1164919821] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14837; }","duration":"123.383882ms","start":"2026-05-30T05:46:12.070681Z","end":"2026-05-30T05:46:12.194065Z","steps":["trace[1164919821] 'agreement among raft nodes before linearized reading'  (duration: 123.133897ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:47:24.506122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12885}
{"level":"info","ts":"2026-05-30T05:47:24.584505Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12885,"took":"75.261683ms","hash":928392337,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":29847552,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-30T05:47:24.584588Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":928392337,"revision":12885,"compact-revision":10741}
{"level":"info","ts":"2026-05-30T05:52:02.929668Z","caller":"traceutil/trace.go:171","msg":"trace[1418015639] linearizableReadLoop","detail":"{readStateIndex:18030; appliedIndex:18029; }","duration":"142.373452ms","start":"2026-05-30T05:52:02.787258Z","end":"2026-05-30T05:52:02.929631Z","steps":["trace[1418015639] 'read index received'  (duration: 142.196419ms)","trace[1418015639] 'applied index is now lower than readState.Index'  (duration: 176.133µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:52:02.930168Z","caller":"traceutil/trace.go:171","msg":"trace[489346509] transaction","detail":"{read_only:false; response_revision:17436; number_of_response:1; }","duration":"154.285146ms","start":"2026-05-30T05:52:02.77587Z","end":"2026-05-30T05:52:02.930155Z","steps":["trace[489346509] 'process raft request'  (duration: 153.469ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:52:02.930463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.174676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-30T05:52:02.930528Z","caller":"traceutil/trace.go:171","msg":"trace[1845173002] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:17436; }","duration":"143.320719ms","start":"2026-05-30T05:52:02.787191Z","end":"2026-05-30T05:52:02.930512Z","steps":["trace[1845173002] 'agreement among raft nodes before linearized reading'  (duration: 143.182996ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:52:03.015926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.161875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T05:52:03.016066Z","caller":"traceutil/trace.go:171","msg":"trace[2005508361] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:17436; }","duration":"126.375348ms","start":"2026-05-30T05:52:02.889653Z","end":"2026-05-30T05:52:03.016029Z","steps":["trace[2005508361] 'agreement among raft nodes before linearized reading'  (duration: 126.120924ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:52:03.235744Z","caller":"traceutil/trace.go:171","msg":"trace[534693584] transaction","detail":"{read_only:false; response_revision:17437; number_of_response:1; }","duration":"214.2674ms","start":"2026-05-30T05:52:03.021438Z","end":"2026-05-30T05:52:03.235705Z","steps":["trace[534693584] 'process raft request'  (duration: 214.029286ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:52:03.236595Z","caller":"traceutil/trace.go:171","msg":"trace[41936442] linearizableReadLoop","detail":"{readStateIndex:18034; appliedIndex:18031; }","duration":"212.148461ms","start":"2026-05-30T05:52:03.02441Z","end":"2026-05-30T05:52:03.236559Z","steps":["trace[41936442] 'read index received'  (duration: 211.115901ms)","trace[41936442] 'applied index is now lower than readState.Index'  (duration: 1.03148ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:52:03.236739Z","caller":"traceutil/trace.go:171","msg":"trace[1859276769] transaction","detail":"{read_only:false; response_revision:17438; number_of_response:1; }","duration":"214.987725ms","start":"2026-05-30T05:52:03.021734Z","end":"2026-05-30T05:52:03.236722Z","steps":["trace[1859276769] 'process raft request'  (duration: 214.594848ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:52:03.236958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.481627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T05:52:03.237043Z","caller":"traceutil/trace.go:171","msg":"trace[2045926495] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:17439; }","duration":"212.64041ms","start":"2026-05-30T05:52:03.024362Z","end":"2026-05-30T05:52:03.237002Z","steps":["trace[2045926495] 'agreement among raft nodes before linearized reading'  (duration: 212.452377ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:52:03.237414Z","caller":"traceutil/trace.go:171","msg":"trace[473812491] transaction","detail":"{read_only:false; response_revision:17439; number_of_response:1; }","duration":"215.601236ms","start":"2026-05-30T05:52:03.021796Z","end":"2026-05-30T05:52:03.237397Z","steps":["trace[473812491] 'process raft request'  (duration: 214.716169ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:52:03.237426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.045357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-30T05:52:03.237519Z","caller":"traceutil/trace.go:171","msg":"trace[1535691080] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17439; }","duration":"177.20265ms","start":"2026-05-30T05:52:03.060291Z","end":"2026-05-30T05:52:03.237494Z","steps":["trace[1535691080] 'agreement among raft nodes before linearized reading'  (duration: 176.934974ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:52:03.237976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.12212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-30T05:52:03.238048Z","caller":"traceutil/trace.go:171","msg":"trace[1953876730] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17439; }","duration":"175.261273ms","start":"2026-05-30T05:52:03.062767Z","end":"2026-05-30T05:52:03.238028Z","steps":["trace[1953876730] 'agreement among raft nodes before linearized reading'  (duration: 174.874206ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:52:03.4192Z","caller":"traceutil/trace.go:171","msg":"trace[1527079373] transaction","detail":"{read_only:false; response_revision:17441; number_of_response:1; }","duration":"175.65201ms","start":"2026-05-30T05:52:03.24352Z","end":"2026-05-30T05:52:03.419172Z","steps":["trace[1527079373] 'process raft request'  (duration: 175.380405ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:52:03.419875Z","caller":"traceutil/trace.go:171","msg":"trace[544685764] transaction","detail":"{read_only:false; response_revision:17440; number_of_response:1; }","duration":"176.354115ms","start":"2026-05-30T05:52:03.243507Z","end":"2026-05-30T05:52:03.419861Z","steps":["trace[544685764] 'process raft request'  (duration: 160.164098ms)","trace[544685764] 'compare'  (duration: 14.992524ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:52:24.515018Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15292}
{"level":"info","ts":"2026-05-30T05:52:24.638903Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15292,"took":"120.010389ms","hash":2208737903,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":31952896,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-30T05:52:24.639029Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2208737903,"revision":15292,"compact-revision":12885}
{"level":"info","ts":"2026-05-30T05:55:50.489815Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-30T05:55:50.497695Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-30T05:55:50.497949Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-30T05:57:24.521762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17706}
{"level":"info","ts":"2026-05-30T05:57:24.622814Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17706,"took":"96.981793ms","hash":3772814422,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":33710080,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-30T05:57:24.622964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3772814422,"revision":17706,"compact-revision":15292}
{"level":"info","ts":"2026-05-30T05:57:26.841013Z","caller":"traceutil/trace.go:171","msg":"trace[157998683] transaction","detail":"{read_only:false; response_revision:19991; number_of_response:1; }","duration":"121.624958ms","start":"2026-05-30T05:57:26.71935Z","end":"2026-05-30T05:57:26.840975Z","steps":["trace[157998683] 'process raft request'  (duration: 121.374654ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:57:27.020007Z","caller":"traceutil/trace.go:171","msg":"trace[1517949792] transaction","detail":"{read_only:false; response_revision:19992; number_of_response:1; }","duration":"121.713351ms","start":"2026-05-30T05:57:26.898236Z","end":"2026-05-30T05:57:27.019949Z","steps":["trace[1517949792] 'process raft request'  (duration: 115.403531ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:57:27.102036Z","caller":"traceutil/trace.go:171","msg":"trace[789709512] transaction","detail":"{read_only:false; response_revision:19993; number_of_response:1; }","duration":"198.436299ms","start":"2026-05-30T05:57:26.90357Z","end":"2026-05-30T05:57:27.102006Z","steps":["trace[789709512] 'process raft request'  (duration: 198.274836ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:57:27.460347Z","caller":"traceutil/trace.go:171","msg":"trace[599397285] transaction","detail":"{read_only:false; response_revision:19994; number_of_response:1; }","duration":"344.313367ms","start":"2026-05-30T05:57:27.116007Z","end":"2026-05-30T05:57:27.460321Z","steps":["trace[599397285] 'process raft request'  (duration: 344.113403ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:57:27.46055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:57:27.115938Z","time spent":"344.52134ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:19984 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-30T05:57:27.469935Z","caller":"traceutil/trace.go:171","msg":"trace[26468552] linearizableReadLoop","detail":"{readStateIndex:20675; appliedIndex:20672; }","duration":"138.65936ms","start":"2026-05-30T05:57:27.331242Z","end":"2026-05-30T05:57:27.469901Z","steps":["trace[26468552] 'read index received'  (duration: 128.954836ms)","trace[26468552] 'applied index is now lower than readState.Index'  (duration: 9.702784ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:57:27.470158Z","caller":"traceutil/trace.go:171","msg":"trace[1507714390] transaction","detail":"{read_only:false; response_revision:19995; number_of_response:1; }","duration":"352.739026ms","start":"2026-05-30T05:57:27.11739Z","end":"2026-05-30T05:57:27.470129Z","steps":["trace[1507714390] 'process raft request'  (duration: 352.215906ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:57:27.470275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:57:27.117368Z","time spent":"352.866578ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:19985 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-30T05:57:27.47018Z","caller":"traceutil/trace.go:171","msg":"trace[1946710833] transaction","detail":"{read_only:false; response_revision:19996; number_of_response:1; }","duration":"351.228347ms","start":"2026-05-30T05:57:27.118926Z","end":"2026-05-30T05:57:27.470154Z","steps":["trace[1946710833] 'process raft request'  (duration: 350.913782ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:57:27.4704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.114179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-30T05:57:27.470555Z","caller":"traceutil/trace.go:171","msg":"trace[840285016] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19996; }","duration":"139.281943ms","start":"2026-05-30T05:57:27.33123Z","end":"2026-05-30T05:57:27.470512Z","steps":["trace[840285016] 'agreement among raft nodes before linearized reading'  (duration: 138.843484ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:57:27.470465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:57:27.118886Z","time spent":"351.545014ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:19986 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-30T05:57:27.470643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.036288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-30T05:57:27.470765Z","caller":"traceutil/trace.go:171","msg":"trace[1315361197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19996; }","duration":"139.230001ms","start":"2026-05-30T05:57:27.331512Z","end":"2026-05-30T05:57:27.470742Z","steps":["trace[1315361197] 'agreement among raft nodes before linearized reading'  (duration: 138.547888ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:57:27.671424Z","caller":"traceutil/trace.go:171","msg":"trace[616877354] transaction","detail":"{read_only:false; response_revision:19998; number_of_response:1; }","duration":"194.269741ms","start":"2026-05-30T05:57:27.47709Z","end":"2026-05-30T05:57:27.67136Z","steps":["trace[616877354] 'process raft request'  (duration: 194.148068ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T05:57:27.67152Z","caller":"traceutil/trace.go:171","msg":"trace[120269273] transaction","detail":"{read_only:false; response_revision:19997; number_of_response:1; }","duration":"195.143446ms","start":"2026-05-30T05:57:27.476322Z","end":"2026-05-30T05:57:27.671466Z","steps":["trace[120269273] 'process raft request'  (duration: 137.994567ms)","trace[120269273] 'compare'  (duration: 56.690401ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:57:27.927828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.924281ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777668130 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:19989 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T05:57:27.927973Z","caller":"traceutil/trace.go:171","msg":"trace[1915744981] linearizableReadLoop","detail":"{readStateIndex:20678; appliedIndex:20677; }","duration":"260.498003ms","start":"2026-05-30T05:57:27.667444Z","end":"2026-05-30T05:57:27.927942Z","steps":["trace[1915744981] 'read index received'  (duration: 108.367269ms)","trace[1915744981] 'applied index is now lower than readState.Index'  (duration: 152.128804ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T05:57:27.928162Z","caller":"traceutil/trace.go:171","msg":"trace[879107962] transaction","detail":"{read_only:false; response_revision:19999; number_of_response:1; }","duration":"262.456609ms","start":"2026-05-30T05:57:27.665649Z","end":"2026-05-30T05:57:27.928105Z","steps":["trace[879107962] 'process raft request'  (duration: 110.141911ms)","trace[879107962] 'compare'  (duration: 151.773548ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T05:57:27.928265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.811938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-30T05:57:27.928337Z","caller":"traceutil/trace.go:171","msg":"trace[83185861] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:19999; }","duration":"260.954272ms","start":"2026-05-30T05:57:27.667361Z","end":"2026-05-30T05:57:27.928316Z","steps":["trace[83185861] 'agreement among raft nodes before linearized reading'  (duration: 260.714806ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:57:27.928465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.191645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T05:57:27.928529Z","caller":"traceutil/trace.go:171","msg":"trace[702094705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:19999; }","duration":"225.261526ms","start":"2026-05-30T05:57:27.703249Z","end":"2026-05-30T05:57:27.928511Z","steps":["trace[702094705] 'agreement among raft nodes before linearized reading'  (duration: 225.159154ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T05:57:28.173054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.991943ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777668135 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:19950 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:67 lease:4089724171922892325 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T05:57:28.173369Z","caller":"traceutil/trace.go:171","msg":"trace[795053847] transaction","detail":"{read_only:false; response_revision:20000; number_of_response:1; }","duration":"155.583081ms","start":"2026-05-30T05:57:28.017751Z","end":"2026-05-30T05:57:28.173334Z","steps":["trace[795053847] 'process raft request'  (duration: 49.120308ms)","trace[795053847] 'compare'  (duration: 105.723918ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:02:24.529783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19979}
{"level":"info","ts":"2026-05-30T06:02:24.650764Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19979,"took":"115.816459ms","hash":296393515,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":41848832,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-30T06:02:24.651007Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":296393515,"revision":19979,"compact-revision":17706}
{"level":"warn","ts":"2026-05-30T06:04:38.137758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.703765ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680215 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24464 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:04:38.138183Z","caller":"traceutil/trace.go:171","msg":"trace[999358587] transaction","detail":"{read_only:false; response_revision:24481; number_of_response:1; }","duration":"130.210323ms","start":"2026-05-30T06:04:38.007948Z","end":"2026-05-30T06:04:38.138158Z","steps":["trace[999358587] 'process raft request'  (duration: 130.145211ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:38.138786Z","caller":"traceutil/trace.go:171","msg":"trace[1631990055] transaction","detail":"{read_only:false; response_revision:24479; number_of_response:1; }","duration":"370.262203ms","start":"2026-05-30T06:04:37.768509Z","end":"2026-05-30T06:04:38.138772Z","steps":["trace[1631990055] 'process raft request'  (duration: 121.411697ms)","trace[1631990055] 'compare'  (duration: 247.296847ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:38.138919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:37.768481Z","time spent":"370.391215ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24464 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-30T06:04:38.139124Z","caller":"traceutil/trace.go:171","msg":"trace[1875387045] transaction","detail":"{read_only:false; response_revision:24480; number_of_response:1; }","duration":"333.979757ms","start":"2026-05-30T06:04:37.805132Z","end":"2026-05-30T06:04:38.139111Z","steps":["trace[1875387045] 'process raft request'  (duration: 332.867306ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.139235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:37.805105Z","time spent":"334.095219ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:24362 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:67 lease:4089724171922904405 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >"}
{"level":"info","ts":"2026-05-30T06:04:38.139446Z","caller":"traceutil/trace.go:171","msg":"trace[1245761516] linearizableReadLoop","detail":"{readStateIndex:25291; appliedIndex:25289; }","duration":"211.511051ms","start":"2026-05-30T06:04:37.927924Z","end":"2026-05-30T06:04:38.139435Z","steps":["trace[1245761516] 'read index received'  (duration: 28.821µs)","trace[1245761516] 'applied index is now lower than readState.Index'  (duration: 211.48105ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:38.139849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.912278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:38.139945Z","caller":"traceutil/trace.go:171","msg":"trace[80414806] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24481; }","duration":"212.04851ms","start":"2026-05-30T06:04:37.927881Z","end":"2026-05-30T06:04:38.13993Z","steps":["trace[80414806] 'agreement among raft nodes before linearized reading'  (duration: 211.912147ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.14041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.528074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-30T06:04:38.140453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.410968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-30T06:04:38.140516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.206958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-30T06:04:38.140585Z","caller":"traceutil/trace.go:171","msg":"trace[453042902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24481; }","duration":"202.583602ms","start":"2026-05-30T06:04:37.937973Z","end":"2026-05-30T06:04:38.140557Z","steps":["trace[453042902] 'agreement among raft nodes before linearized reading'  (duration: 202.215165ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:38.14061Z","caller":"traceutil/trace.go:171","msg":"trace[439885735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24481; }","duration":"107.369461ms","start":"2026-05-30T06:04:38.033218Z","end":"2026-05-30T06:04:38.140588Z","steps":["trace[439885735] 'agreement among raft nodes before linearized reading'  (duration: 107.061495ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:38.1405Z","caller":"traceutil/trace.go:171","msg":"trace[1599616556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24481; }","duration":"107.665517ms","start":"2026-05-30T06:04:38.032823Z","end":"2026-05-30T06:04:38.140489Z","steps":["trace[1599616556] 'agreement among raft nodes before linearized reading'  (duration: 107.481743ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:38.481597Z","caller":"traceutil/trace.go:171","msg":"trace[316094585] transaction","detail":"{read_only:false; response_revision:24482; number_of_response:1; }","duration":"328.400111ms","start":"2026-05-30T06:04:38.153157Z","end":"2026-05-30T06:04:38.481557Z","steps":["trace[316094585] 'process raft request'  (duration: 313.409679ms)","trace[316094585] 'compare'  (duration: 14.038595ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:38.481806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.153134Z","time spent":"328.553314ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24468 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-30T06:04:38.489144Z","caller":"traceutil/trace.go:171","msg":"trace[1990409853] linearizableReadLoop","detail":"{readStateIndex:25295; appliedIndex:25292; }","duration":"334.332234ms","start":"2026-05-30T06:04:38.154776Z","end":"2026-05-30T06:04:38.489108Z","steps":["trace[1990409853] 'read index received'  (duration: 311.812818ms)","trace[1990409853] 'applied index is now lower than readState.Index'  (duration: 22.518196ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:38.48919Z","caller":"traceutil/trace.go:171","msg":"trace[1959996904] transaction","detail":"{read_only:false; response_revision:24483; number_of_response:1; }","duration":"335.221281ms","start":"2026-05-30T06:04:38.153936Z","end":"2026-05-30T06:04:38.489157Z","steps":["trace[1959996904] 'process raft request'  (duration: 334.985626ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:38.489293Z","caller":"traceutil/trace.go:171","msg":"trace[371631689] transaction","detail":"{read_only:false; response_revision:24484; number_of_response:1; }","duration":"335.091148ms","start":"2026-05-30T06:04:38.154189Z","end":"2026-05-30T06:04:38.48928Z","steps":["trace[371631689] 'process raft request'  (duration: 334.873064ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.489399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.153918Z","time spent":"335.395924ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24467 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:38.489423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.154162Z","time spent":"335.17398ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24465 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:38.489495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.722081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-30T06:04:38.489554Z","caller":"traceutil/trace.go:171","msg":"trace[193850768] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:24484; }","duration":"334.813173ms","start":"2026-05-30T06:04:38.154728Z","end":"2026-05-30T06:04:38.489541Z","steps":["trace[193850768] 'agreement among raft nodes before linearized reading'  (duration: 334.66809ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.489575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.154715Z","time spent":"334.854763ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "}
{"level":"warn","ts":"2026-05-30T06:04:38.761909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.242229ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680224 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24472 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:04:38.76206Z","caller":"traceutil/trace.go:171","msg":"trace[114692684] linearizableReadLoop","detail":"{readStateIndex:25296; appliedIndex:25295; }","duration":"272.80863ms","start":"2026-05-30T06:04:38.489226Z","end":"2026-05-30T06:04:38.762035Z","steps":["trace[114692684] 'read index received'  (duration: 120.274315ms)","trace[114692684] 'applied index is now lower than readState.Index'  (duration: 152.531875ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:38.762144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.493538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:38.762181Z","caller":"traceutil/trace.go:171","msg":"trace[160424145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24485; }","duration":"305.578851ms","start":"2026-05-30T06:04:38.456593Z","end":"2026-05-30T06:04:38.762171Z","steps":["trace[160424145] 'agreement among raft nodes before linearized reading'  (duration: 305.493379ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.762226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.456561Z","time spent":"305.657881ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-30T06:04:38.76243Z","caller":"traceutil/trace.go:171","msg":"trace[1759629021] transaction","detail":"{read_only:false; response_revision:24485; number_of_response:1; }","duration":"289.338363ms","start":"2026-05-30T06:04:38.473037Z","end":"2026-05-30T06:04:38.762375Z","steps":["trace[1759629021] 'process raft request'  (duration: 136.532473ms)","trace[1759629021] 'compare'  (duration: 151.928843ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:38.762479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.393276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-30T06:04:38.762538Z","caller":"traceutil/trace.go:171","msg":"trace[1399381530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24485; }","duration":"545.487398ms","start":"2026-05-30T06:04:38.217038Z","end":"2026-05-30T06:04:38.762525Z","steps":["trace[1399381530] 'agreement among raft nodes before linearized reading'  (duration: 545.211533ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.762582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.903745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-30T06:04:38.762609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.21701Z","time spent":"545.587949ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-30T06:04:38.762745Z","caller":"traceutil/trace.go:171","msg":"trace[746447452] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24485; }","duration":"271.132628ms","start":"2026-05-30T06:04:38.491573Z","end":"2026-05-30T06:04:38.762706Z","steps":["trace[746447452] 'agreement among raft nodes before linearized reading'  (duration: 270.794842ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.762617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.310089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-30T06:04:38.763317Z","caller":"traceutil/trace.go:171","msg":"trace[1054815498] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24485; }","duration":"550.737607ms","start":"2026-05-30T06:04:38.212204Z","end":"2026-05-30T06:04:38.762942Z","steps":["trace[1054815498] 'agreement among raft nodes before linearized reading'  (duration: 550.192797ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:38.763468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.212168Z","time spent":"551.246136ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-30T06:04:39.13563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.207794ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24470 > 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-05-30T06:04:39.135783Z","caller":"traceutil/trace.go:171","msg":"trace[352015886] transaction","detail":"{read_only:false; response_revision:24486; number_of_response:1; }","duration":"368.046882ms","start":"2026-05-30T06:04:38.767707Z","end":"2026-05-30T06:04:39.135754Z","steps":["trace[352015886] 'process raft request'  (duration: 137.571672ms)","trace[352015886] 'compare'  (duration: 229.682264ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:39.135853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.767676Z","time spent":"368.145933ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24470 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:39.457639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.272048ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680230 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24469 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:462 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:04:39.458155Z","caller":"traceutil/trace.go:171","msg":"trace[1251880791] transaction","detail":"{read_only:false; response_revision:24490; number_of_response:1; }","duration":"425.559799ms","start":"2026-05-30T06:04:39.032577Z","end":"2026-05-30T06:04:39.458137Z","steps":["trace[1251880791] 'process raft request'  (duration: 425.519138ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:39.458224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:39.032564Z","time spent":"425.62836ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24475 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-30T06:04:39.458223Z","caller":"traceutil/trace.go:171","msg":"trace[296010996] transaction","detail":"{read_only:false; response_revision:24488; number_of_response:1; }","duration":"652.357779ms","start":"2026-05-30T06:04:38.805814Z","end":"2026-05-30T06:04:39.458172Z","steps":["trace[296010996] 'process raft request'  (duration: 652.172705ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:39.458301Z","caller":"traceutil/trace.go:171","msg":"trace[1953584360] linearizableReadLoop","detail":"{readStateIndex:25299; appliedIndex:25297; }","duration":"477.962089ms","start":"2026-05-30T06:04:38.980315Z","end":"2026-05-30T06:04:39.458277Z","steps":["trace[1953584360] 'read index received'  (duration: 313.845446ms)","trace[1953584360] 'applied index is now lower than readState.Index'  (duration: 164.113843ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:39.458345Z","caller":"traceutil/trace.go:171","msg":"trace[395192292] transaction","detail":"{read_only:false; response_revision:24489; number_of_response:1; }","duration":"427.544116ms","start":"2026-05-30T06:04:39.030769Z","end":"2026-05-30T06:04:39.458314Z","steps":["trace[395192292] 'process raft request'  (duration: 427.289361ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:39.458326Z","caller":"traceutil/trace.go:171","msg":"trace[1951041219] transaction","detail":"{read_only:false; response_revision:24487; number_of_response:1; }","duration":"690.53544ms","start":"2026-05-30T06:04:38.767733Z","end":"2026-05-30T06:04:39.458269Z","steps":["trace[1951041219] 'process raft request'  (duration: 526.521098ms)","trace[1951041219] 'compare'  (duration: 162.962002ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:39.458482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.805785Z","time spent":"652.553183ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24473 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:39.458501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:39.03074Z","time spent":"427.675779ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24474 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:39.458543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.224544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"}
{"level":"info","ts":"2026-05-30T06:04:39.458579Z","caller":"traceutil/trace.go:171","msg":"trace[1179720625] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24490; }","duration":"478.298356ms","start":"2026-05-30T06:04:38.98027Z","end":"2026-05-30T06:04:39.458568Z","steps":["trace[1179720625] 'agreement among raft nodes before linearized reading'  (duration: 478.125523ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:39.458606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.980243Z","time spent":"478.357238ms","remote":"127.0.0.1:45354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11861,"request content":"key:\"/registry/deployments/openstack/glance-api\" "}
{"level":"warn","ts":"2026-05-30T06:04:39.458578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.203097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-30T06:04:39.458697Z","caller":"traceutil/trace.go:171","msg":"trace[2018527428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24490; }","duration":"181.39695ms","start":"2026-05-30T06:04:39.27729Z","end":"2026-05-30T06:04:39.458687Z","steps":["trace[2018527428] 'agreement among raft nodes before linearized reading'  (duration: 181.229887ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:39.458584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:38.767711Z","time spent":"690.729364ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24469 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:462 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:44.978765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.365937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:44.978907Z","caller":"traceutil/trace.go:171","msg":"trace[572748571] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:24528; }","duration":"138.596721ms","start":"2026-05-30T06:04:44.840277Z","end":"2026-05-30T06:04:44.978874Z","steps":["trace[572748571] 'count revisions from in-memory index tree'  (duration: 138.244304ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:45.302018Z","caller":"traceutil/trace.go:171","msg":"trace[1142184300] transaction","detail":"{read_only:false; response_revision:24529; number_of_response:1; }","duration":"129.279506ms","start":"2026-05-30T06:04:45.172701Z","end":"2026-05-30T06:04:45.30198Z","steps":["trace[1142184300] 'process raft request'  (duration: 129.063141ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:45.789864Z","caller":"traceutil/trace.go:171","msg":"trace[255851495] linearizableReadLoop","detail":"{readStateIndex:25344; appliedIndex:25341; }","duration":"289.973145ms","start":"2026-05-30T06:04:45.499858Z","end":"2026-05-30T06:04:45.789831Z","steps":["trace[255851495] 'read index received'  (duration: 11.040959ms)","trace[255851495] 'applied index is now lower than readState.Index'  (duration: 278.930946ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:45.789942Z","caller":"traceutil/trace.go:171","msg":"trace[665959149] transaction","detail":"{read_only:false; response_revision:24532; number_of_response:1; }","duration":"303.959268ms","start":"2026-05-30T06:04:45.485965Z","end":"2026-05-30T06:04:45.789925Z","steps":["trace[665959149] 'process raft request'  (duration: 303.806336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:45.789973Z","caller":"traceutil/trace.go:171","msg":"trace[1119784192] transaction","detail":"{read_only:false; response_revision:24531; number_of_response:1; }","duration":"304.709963ms","start":"2026-05-30T06:04:45.485196Z","end":"2026-05-30T06:04:45.789906Z","steps":["trace[1119784192] 'process raft request'  (duration: 304.388057ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:45.790119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.24552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"warn","ts":"2026-05-30T06:04:45.790128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:45.485953Z","time spent":"304.086102ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24516 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-30T06:04:45.790172Z","caller":"traceutil/trace.go:171","msg":"trace[2099710662] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24532; }","duration":"290.32397ms","start":"2026-05-30T06:04:45.499822Z","end":"2026-05-30T06:04:45.790146Z","steps":["trace[2099710662] 'agreement among raft nodes before linearized reading'  (duration: 290.149647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:45.790188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:45.48516Z","time spent":"304.906527ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24517 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:46.052516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.223418ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680338 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24519 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:04:46.052881Z","caller":"traceutil/trace.go:171","msg":"trace[2026765011] transaction","detail":"{read_only:false; response_revision:24534; number_of_response:1; }","duration":"257.670674ms","start":"2026-05-30T06:04:45.79518Z","end":"2026-05-30T06:04:46.05285Z","steps":["trace[2026765011] 'process raft request'  (duration: 257.511591ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:46.053138Z","caller":"traceutil/trace.go:171","msg":"trace[1287769251] transaction","detail":"{read_only:false; response_revision:24533; number_of_response:1; }","duration":"463.459086ms","start":"2026-05-30T06:04:45.589652Z","end":"2026-05-30T06:04:46.053111Z","steps":["trace[1287769251] 'process raft request'  (duration: 327.526175ms)","trace[1287769251] 'compare'  (duration: 134.760648ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:46.053164Z","caller":"traceutil/trace.go:171","msg":"trace[2066414077] linearizableReadLoop","detail":"{readStateIndex:25345; appliedIndex:25344; }","duration":"263.171338ms","start":"2026-05-30T06:04:45.789945Z","end":"2026-05-30T06:04:46.053116Z","steps":["trace[2066414077] 'read index received'  (duration: 127.250757ms)","trace[2066414077] 'applied index is now lower than readState.Index'  (duration: 135.915231ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:46.053267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:45.589624Z","time spent":"463.584548ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24519 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:46.053375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.659612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:46.053452Z","caller":"traceutil/trace.go:171","msg":"trace[1052605750] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:24534; }","duration":"479.799385ms","start":"2026-05-30T06:04:45.573634Z","end":"2026-05-30T06:04:46.053433Z","steps":["trace[1052605750] 'agreement among raft nodes before linearized reading'  (duration: 479.655982ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.053438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.017414ms","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-05-30T06:04:46.053508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:45.573607Z","time spent":"479.887076ms","remote":"127.0.0.1:56234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true "}
{"level":"info","ts":"2026-05-30T06:04:46.053521Z","caller":"traceutil/trace.go:171","msg":"trace[175084498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24534; }","duration":"457.162067ms","start":"2026-05-30T06:04:45.596337Z","end":"2026-05-30T06:04:46.053499Z","steps":["trace[175084498] 'agreement among raft nodes before linearized reading'  (duration: 456.828171ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.053571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:45.596309Z","time spent":"457.253588ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-30T06:04:46.366311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.905918ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680344 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24520 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:04:46.366438Z","caller":"traceutil/trace.go:171","msg":"trace[673231923] linearizableReadLoop","detail":"{readStateIndex:25347; appliedIndex:25346; }","duration":"307.596838ms","start":"2026-05-30T06:04:46.05882Z","end":"2026-05-30T06:04:46.366417Z","steps":["trace[673231923] 'read index received'  (duration: 150.472696ms)","trace[673231923] 'applied index is now lower than readState.Index'  (duration: 157.122852ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:46.366514Z","caller":"traceutil/trace.go:171","msg":"trace[783184754] transaction","detail":"{read_only:false; response_revision:24535; number_of_response:1; }","duration":"308.551435ms","start":"2026-05-30T06:04:46.057949Z","end":"2026-05-30T06:04:46.366501Z","steps":["trace[783184754] 'process raft request'  (duration: 151.305261ms)","trace[783184754] 'compare'  (duration: 156.651043ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:46.366573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:46.057931Z","time spent":"308.608907ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24520 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:46.366892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.064607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18366"}
{"level":"info","ts":"2026-05-30T06:04:46.366949Z","caller":"traceutil/trace.go:171","msg":"trace[1221182719] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24535; }","duration":"308.106548ms","start":"2026-05-30T06:04:46.058805Z","end":"2026-05-30T06:04:46.366911Z","steps":["trace[1221182719] 'agreement among raft nodes before linearized reading'  (duration: 307.963405ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.366979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:46.058798Z","time spent":"308.174549ms","remote":"127.0.0.1:46832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18390,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-05-30T06:04:46.378584Z","caller":"traceutil/trace.go:171","msg":"trace[589025428] transaction","detail":"{read_only:false; response_revision:24536; number_of_response:1; }","duration":"194.092801ms","start":"2026-05-30T06:04:46.184451Z","end":"2026-05-30T06:04:46.378543Z","steps":["trace[589025428] 'process raft request'  (duration: 193.886617ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.378655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.28951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-05-30T06:04:46.378614Z","caller":"traceutil/trace.go:171","msg":"trace[21990836] transaction","detail":"{read_only:false; response_revision:24537; number_of_response:1; }","duration":"189.486715ms","start":"2026-05-30T06:04:46.189085Z","end":"2026-05-30T06:04:46.378572Z","steps":["trace[21990836] 'process raft request'  (duration: 189.376252ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:46.378716Z","caller":"traceutil/trace.go:171","msg":"trace[32972646] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24537; }","duration":"134.399942ms","start":"2026-05-30T06:04:46.244299Z","end":"2026-05-30T06:04:46.378699Z","steps":["trace[32972646] 'agreement among raft nodes before linearized reading'  (duration: 134.224888ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.731959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.832384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:04:46.732093Z","caller":"traceutil/trace.go:171","msg":"trace[780443232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24538; }","duration":"205.053768ms","start":"2026-05-30T06:04:46.527009Z","end":"2026-05-30T06:04:46.732062Z","steps":["trace[780443232] 'range keys from in-memory index tree'  (duration: 204.530549ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.7322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.971615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-30T06:04:46.732302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.816779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-30T06:04:46.732378Z","caller":"traceutil/trace.go:171","msg":"trace[1541890662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24538; }","duration":"197.18753ms","start":"2026-05-30T06:04:46.535133Z","end":"2026-05-30T06:04:46.732321Z","steps":["trace[1541890662] 'range keys from in-memory index tree'  (duration: 196.678531ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:46.732399Z","caller":"traceutil/trace.go:171","msg":"trace[1776014125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24538; }","duration":"190.957801ms","start":"2026-05-30T06:04:46.541419Z","end":"2026-05-30T06:04:46.732377Z","steps":["trace[1776014125] 'range keys from in-memory index tree'  (duration: 190.606065ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:46.733053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.922757ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680361 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:24471 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:18"}
{"level":"warn","ts":"2026-05-30T06:04:46.732252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.564266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"info","ts":"2026-05-30T06:04:46.73316Z","caller":"traceutil/trace.go:171","msg":"trace[1253506229] transaction","detail":"{read_only:false; response_revision:24539; number_of_response:1; }","duration":"186.467757ms","start":"2026-05-30T06:04:46.546667Z","end":"2026-05-30T06:04:46.733135Z","steps":["trace[1253506229] 'process raft request'  (duration: 55.330596ms)","trace[1253506229] 'compare'  (duration: 130.448438ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:46.733211Z","caller":"traceutil/trace.go:171","msg":"trace[1430226306] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24538; }","duration":"263.558825ms","start":"2026-05-30T06:04:46.469622Z","end":"2026-05-30T06:04:46.733181Z","steps":["trace[1430226306] 'range keys from in-memory index tree'  (duration: 262.342502ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.024731Z","caller":"traceutil/trace.go:171","msg":"trace[1500743126] transaction","detail":"{read_only:false; response_revision:24541; number_of_response:1; }","duration":"286.218553ms","start":"2026-05-30T06:04:46.738477Z","end":"2026-05-30T06:04:47.024696Z","steps":["trace[1500743126] 'process raft request'  (duration: 285.965159ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.02512Z","caller":"traceutil/trace.go:171","msg":"trace[1530701176] transaction","detail":"{read_only:false; response_revision:24542; number_of_response:1; }","duration":"284.546122ms","start":"2026-05-30T06:04:46.740563Z","end":"2026-05-30T06:04:47.025109Z","steps":["trace[1530701176] 'process raft request'  (duration: 284.079783ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.025255Z","caller":"traceutil/trace.go:171","msg":"trace[996387973] linearizableReadLoop","detail":"{readStateIndex:25354; appliedIndex:25351; }","duration":"253.476774ms","start":"2026-05-30T06:04:46.771753Z","end":"2026-05-30T06:04:47.02523Z","steps":["trace[996387973] 'read index received'  (duration: 42.091546ms)","trace[996387973] 'applied index is now lower than readState.Index'  (duration: 211.384288ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:47.025346Z","caller":"traceutil/trace.go:171","msg":"trace[997404581] transaction","detail":"{read_only:false; response_revision:24543; number_of_response:1; }","duration":"233.403774ms","start":"2026-05-30T06:04:46.791912Z","end":"2026-05-30T06:04:47.025316Z","steps":["trace[997404581] 'process raft request'  (duration: 233.092498ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:47.025402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.619327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:47.025451Z","caller":"traceutil/trace.go:171","msg":"trace[2033193784] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:24543; }","duration":"253.71733ms","start":"2026-05-30T06:04:46.771721Z","end":"2026-05-30T06:04:47.025438Z","steps":["trace[2033193784] 'agreement among raft nodes before linearized reading'  (duration: 253.614117ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.252641Z","caller":"traceutil/trace.go:171","msg":"trace[747624851] linearizableReadLoop","detail":"{readStateIndex:25356; appliedIndex:25355; }","duration":"152.073636ms","start":"2026-05-30T06:04:47.100538Z","end":"2026-05-30T06:04:47.252611Z","steps":["trace[747624851] 'read index received'  (duration: 149.923495ms)","trace[747624851] 'applied index is now lower than readState.Index'  (duration: 2.149041ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:47.25287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.316881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:47.252923Z","caller":"traceutil/trace.go:171","msg":"trace[506749566] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24544; }","duration":"152.445344ms","start":"2026-05-30T06:04:47.100457Z","end":"2026-05-30T06:04:47.252902Z","steps":["trace[506749566] 'agreement among raft nodes before linearized reading'  (duration: 152.288301ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.252992Z","caller":"traceutil/trace.go:171","msg":"trace[948746121] transaction","detail":"{read_only:false; response_revision:24544; number_of_response:1; }","duration":"221.203214ms","start":"2026-05-30T06:04:47.031718Z","end":"2026-05-30T06:04:47.252922Z","steps":["trace[948746121] 'process raft request'  (duration: 218.835829ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.464255Z","caller":"traceutil/trace.go:171","msg":"trace[1540990560] transaction","detail":"{read_only:false; response_revision:24546; number_of_response:1; }","duration":"151.843483ms","start":"2026-05-30T06:04:47.312377Z","end":"2026-05-30T06:04:47.46422Z","steps":["trace[1540990560] 'process raft request'  (duration: 150.020948ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.898155Z","caller":"traceutil/trace.go:171","msg":"trace[868818945] linearizableReadLoop","detail":"{readStateIndex:25359; appliedIndex:25358; }","duration":"321.130525ms","start":"2026-05-30T06:04:47.576999Z","end":"2026-05-30T06:04:47.89813Z","steps":["trace[868818945] 'read index received'  (duration: 320.954472ms)","trace[868818945] 'applied index is now lower than readState.Index'  (duration: 175.033µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:47.898317Z","caller":"traceutil/trace.go:171","msg":"trace[1095395756] transaction","detail":"{read_only:false; response_revision:24547; number_of_response:1; }","duration":"354.140238ms","start":"2026-05-30T06:04:47.544165Z","end":"2026-05-30T06:04:47.898305Z","steps":["trace[1095395756] 'process raft request'  (duration: 353.790172ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:47.898418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:47.544126Z","time spent":"354.21361ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24530 > 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-05-30T06:04:47.898581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.588363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:47.898643Z","caller":"traceutil/trace.go:171","msg":"trace[1675450855] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:24547; }","duration":"321.705125ms","start":"2026-05-30T06:04:47.576924Z","end":"2026-05-30T06:04:47.898629Z","steps":["trace[1675450855] 'agreement among raft nodes before linearized reading'  (duration: 321.590523ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:47.898684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:47.576898Z","time spent":"321.776096ms","remote":"127.0.0.1:60594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-30T06:04:47.924654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.806652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-30T06:04:47.924774Z","caller":"traceutil/trace.go:171","msg":"trace[1723330520] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:24550; }","duration":"234.980285ms","start":"2026-05-30T06:04:47.689749Z","end":"2026-05-30T06:04:47.924729Z","steps":["trace[1723330520] 'agreement among raft nodes before linearized reading'  (duration: 234.71351ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.925286Z","caller":"traceutil/trace.go:171","msg":"trace[2084653589] transaction","detail":"{read_only:false; response_revision:24548; number_of_response:1; }","duration":"173.275688ms","start":"2026-05-30T06:04:47.751998Z","end":"2026-05-30T06:04:47.925274Z","steps":["trace[2084653589] 'process raft request'  (duration: 171.757279ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.925423Z","caller":"traceutil/trace.go:171","msg":"trace[1419046907] transaction","detail":"{read_only:false; response_revision:24549; number_of_response:1; }","duration":"123.088429ms","start":"2026-05-30T06:04:47.802323Z","end":"2026-05-30T06:04:47.925412Z","steps":["trace[1419046907] 'process raft request'  (duration: 121.616641ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:47.92552Z","caller":"traceutil/trace.go:171","msg":"trace[1438080858] transaction","detail":"{read_only:false; response_revision:24550; number_of_response:1; }","duration":"121.884795ms","start":"2026-05-30T06:04:47.803628Z","end":"2026-05-30T06:04:47.925512Z","steps":["trace[1438080858] 'process raft request'  (duration: 120.366327ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:47.925642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.075716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:47.925666Z","caller":"traceutil/trace.go:171","msg":"trace[1161115277] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24550; }","duration":"143.135837ms","start":"2026-05-30T06:04:47.78252Z","end":"2026-05-30T06:04:47.925656Z","steps":["trace[1161115277] 'agreement among raft nodes before linearized reading'  (duration: 143.078946ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:48.119176Z","caller":"traceutil/trace.go:171","msg":"trace[261381089] linearizableReadLoop","detail":"{readStateIndex:25363; appliedIndex:25362; }","duration":"126.89991ms","start":"2026-05-30T06:04:47.992238Z","end":"2026-05-30T06:04:48.119138Z","steps":["trace[261381089] 'read index received'  (duration: 75.818643ms)","trace[261381089] 'applied index is now lower than readState.Index'  (duration: 51.078647ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:48.119562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.284348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:48.119632Z","caller":"traceutil/trace.go:171","msg":"trace[1317330827] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:24551; }","duration":"127.405269ms","start":"2026-05-30T06:04:47.992187Z","end":"2026-05-30T06:04:48.119592Z","steps":["trace[1317330827] 'agreement among raft nodes before linearized reading'  (duration: 127.192216ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:48.424312Z","caller":"traceutil/trace.go:171","msg":"trace[486104807] linearizableReadLoop","detail":"{readStateIndex:25366; appliedIndex:25365; }","duration":"281.338772ms","start":"2026-05-30T06:04:48.142941Z","end":"2026-05-30T06:04:48.42428Z","steps":["trace[486104807] 'read index received'  (duration: 228.236497ms)","trace[486104807] 'applied index is now lower than readState.Index'  (duration: 53.101425ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:48.42446Z","caller":"traceutil/trace.go:171","msg":"trace[1473417984] transaction","detail":"{read_only:false; response_revision:24553; number_of_response:1; }","duration":"298.66887ms","start":"2026-05-30T06:04:48.125771Z","end":"2026-05-30T06:04:48.42444Z","steps":["trace[1473417984] 'process raft request'  (duration: 245.500694ms)","trace[1473417984] 'compare'  (duration: 52.865909ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:48.424994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.019314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-05-30T06:04:48.425165Z","caller":"traceutil/trace.go:171","msg":"trace[1553883676] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24553; }","duration":"282.247227ms","start":"2026-05-30T06:04:48.142892Z","end":"2026-05-30T06:04:48.425139Z","steps":["trace[1553883676] 'agreement among raft nodes before linearized reading'  (duration: 281.594835ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:48.437717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.938255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-30T06:04:48.437784Z","caller":"traceutil/trace.go:171","msg":"trace[1501417232] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:24555; }","duration":"289.061357ms","start":"2026-05-30T06:04:48.148707Z","end":"2026-05-30T06:04:48.437768Z","steps":["trace[1501417232] 'agreement among raft nodes before linearized reading'  (duration: 288.816143ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:48.635808Z","caller":"traceutil/trace.go:171","msg":"trace[773685358] linearizableReadLoop","detail":"{readStateIndex:25369; appliedIndex:25368; }","duration":"177.259283ms","start":"2026-05-30T06:04:48.458517Z","end":"2026-05-30T06:04:48.635776Z","steps":["trace[773685358] 'read index received'  (duration: 123.951925ms)","trace[773685358] 'applied index is now lower than readState.Index'  (duration: 53.298858ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:48.635835Z","caller":"traceutil/trace.go:171","msg":"trace[1866713443] transaction","detail":"{read_only:false; response_revision:24556; number_of_response:1; }","duration":"177.65005ms","start":"2026-05-30T06:04:48.458147Z","end":"2026-05-30T06:04:48.635797Z","steps":["trace[1866713443] 'process raft request'  (duration: 124.393593ms)","trace[1866713443] 'compare'  (duration: 53.081924ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:48.636014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.467697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:48.636124Z","caller":"traceutil/trace.go:171","msg":"trace[629265947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24556; }","duration":"177.60915ms","start":"2026-05-30T06:04:48.458495Z","end":"2026-05-30T06:04:48.636104Z","steps":["trace[629265947] 'agreement among raft nodes before linearized reading'  (duration: 177.455217ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:49.255154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.054817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-30T06:04:49.255234Z","caller":"traceutil/trace.go:171","msg":"trace[160809694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24557; }","duration":"225.18824ms","start":"2026-05-30T06:04:49.030027Z","end":"2026-05-30T06:04:49.255215Z","steps":["trace[160809694] 'range keys from in-memory index tree'  (duration: 224.887174ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:49.255503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.050138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:04:49.255524Z","caller":"traceutil/trace.go:171","msg":"trace[676942010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24557; }","duration":"224.087068ms","start":"2026-05-30T06:04:49.03143Z","end":"2026-05-30T06:04:49.255517Z","steps":["trace[676942010] 'range keys from in-memory index tree'  (duration: 223.964826ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:49.339438Z","caller":"traceutil/trace.go:171","msg":"trace[2058341411] transaction","detail":"{read_only:false; response_revision:24558; number_of_response:1; }","duration":"307.012476ms","start":"2026-05-30T06:04:49.0324Z","end":"2026-05-30T06:04:49.339413Z","steps":["trace[2058341411] 'process raft request'  (duration: 306.849883ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:49.339609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:49.032362Z","time spent":"307.142849ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24543 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-30T06:04:49.674569Z","caller":"traceutil/trace.go:171","msg":"trace[1499737227] linearizableReadLoop","detail":"{readStateIndex:25374; appliedIndex:25371; }","duration":"204.461648ms","start":"2026-05-30T06:04:49.470084Z","end":"2026-05-30T06:04:49.674546Z","steps":["trace[1499737227] 'read index received'  (duration: 180.146127ms)","trace[1499737227] 'applied index is now lower than readState.Index'  (duration: 24.314591ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:49.67479Z","caller":"traceutil/trace.go:171","msg":"trace[380901470] transaction","detail":"{read_only:false; response_revision:24559; number_of_response:1; }","duration":"582.260893ms","start":"2026-05-30T06:04:49.092512Z","end":"2026-05-30T06:04:49.674773Z","steps":["trace[380901470] 'process raft request'  (duration: 557.925922ms)","trace[380901470] 'compare'  (duration: 23.499875ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:49.674916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:49.09247Z","time spent":"582.359495ms","remote":"127.0.0.1:56078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418442,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:23974 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:418374 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"info","ts":"2026-05-30T06:04:49.675264Z","caller":"traceutil/trace.go:171","msg":"trace[1633529105] transaction","detail":"{read_only:false; response_revision:24561; number_of_response:1; }","duration":"411.819619ms","start":"2026-05-30T06:04:49.263435Z","end":"2026-05-30T06:04:49.675255Z","steps":["trace[1633529105] 'process raft request'  (duration: 411.069306ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:49.675261Z","caller":"traceutil/trace.go:171","msg":"trace[1947159086] transaction","detail":"{read_only:false; response_revision:24560; number_of_response:1; }","duration":"411.916181ms","start":"2026-05-30T06:04:49.26332Z","end":"2026-05-30T06:04:49.675236Z","steps":["trace[1947159086] 'process raft request'  (duration: 411.138936ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:49.675332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:49.263413Z","time spent":"411.88025ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24542 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:49.675359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:49.263283Z","time spent":"412.025012ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24541 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:49.678059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.78147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-30T06:04:49.678191Z","caller":"traceutil/trace.go:171","msg":"trace[1795775482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24561; }","duration":"208.120417ms","start":"2026-05-30T06:04:49.470041Z","end":"2026-05-30T06:04:49.678161Z","steps":["trace[1795775482] 'agreement among raft nodes before linearized reading'  (duration: 204.602301ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:50.0206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.78644ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777680407 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24546 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:04:50.020854Z","caller":"traceutil/trace.go:171","msg":"trace[1844344146] transaction","detail":"{read_only:false; response_revision:24563; number_of_response:1; }","duration":"116.662976ms","start":"2026-05-30T06:04:49.904168Z","end":"2026-05-30T06:04:50.020831Z","steps":["trace[1844344146] 'process raft request'  (duration: 116.579144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:50.020847Z","caller":"traceutil/trace.go:171","msg":"trace[1175151030] transaction","detail":"{read_only:false; response_revision:24562; number_of_response:1; }","duration":"334.784292ms","start":"2026-05-30T06:04:49.686022Z","end":"2026-05-30T06:04:50.020806Z","steps":["trace[1175151030] 'process raft request'  (duration: 135.672296ms)","trace[1175151030] 'compare'  (duration: 198.606846ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:50.021053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:49.685999Z","time spent":"334.931745ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24546 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-30T06:04:50.230964Z","caller":"traceutil/trace.go:171","msg":"trace[268640218] transaction","detail":"{read_only:false; response_revision:24564; number_of_response:1; }","duration":"300.329101ms","start":"2026-05-30T06:04:49.930598Z","end":"2026-05-30T06:04:50.230927Z","steps":["trace[268640218] 'process raft request'  (duration: 250.473227ms)","trace[268640218] 'compare'  (duration: 49.198631ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:50.231183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:49.93057Z","time spent":"300.503804ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24549 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-30T06:04:50.231113Z","caller":"traceutil/trace.go:171","msg":"trace[564977522] linearizableReadLoop","detail":"{readStateIndex:25378; appliedIndex:25374; }","duration":"277.304985ms","start":"2026-05-30T06:04:49.953787Z","end":"2026-05-30T06:04:50.231092Z","steps":["trace[564977522] 'read index received'  (duration: 55.443909ms)","trace[564977522] 'applied index is now lower than readState.Index'  (duration: 221.825265ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:50.231319Z","caller":"traceutil/trace.go:171","msg":"trace[1158672340] transaction","detail":"{read_only:false; response_revision:24565; number_of_response:1; }","duration":"298.627818ms","start":"2026-05-30T06:04:49.932653Z","end":"2026-05-30T06:04:50.231281Z","steps":["trace[1158672340] 'process raft request'  (duration: 298.18603ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:50.231617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.823354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18366"}
{"level":"info","ts":"2026-05-30T06:04:50.231706Z","caller":"traceutil/trace.go:171","msg":"trace[1699365651] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24565; }","duration":"277.960166ms","start":"2026-05-30T06:04:49.95373Z","end":"2026-05-30T06:04:50.23169Z","steps":["trace[1699365651] 'agreement among raft nodes before linearized reading'  (duration: 277.6355ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:50.393122Z","caller":"traceutil/trace.go:171","msg":"trace[868113118] linearizableReadLoop","detail":"{readStateIndex:25379; appliedIndex:25378; }","duration":"153.943222ms","start":"2026-05-30T06:04:50.239148Z","end":"2026-05-30T06:04:50.393091Z","steps":["trace[868113118] 'read index received'  (duration: 110.46139ms)","trace[868113118] 'applied index is now lower than readState.Index'  (duration: 43.480122ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:50.393251Z","caller":"traceutil/trace.go:171","msg":"trace[1898061146] transaction","detail":"{read_only:false; response_revision:24566; number_of_response:1; }","duration":"261.808112ms","start":"2026-05-30T06:04:50.131416Z","end":"2026-05-30T06:04:50.393224Z","steps":["trace[1898061146] 'process raft request'  (duration: 218.30494ms)","trace[1898061146] 'compare'  (duration: 43.160436ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:04:50.393404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.241717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18366"}
{"level":"info","ts":"2026-05-30T06:04:50.393489Z","caller":"traceutil/trace.go:171","msg":"trace[787701565] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24566; }","duration":"154.38079ms","start":"2026-05-30T06:04:50.239092Z","end":"2026-05-30T06:04:50.393473Z","steps":["trace[787701565] 'agreement among raft nodes before linearized reading'  (duration: 154.133655ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:56.997388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.108191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-30T06:04:56.997619Z","caller":"traceutil/trace.go:171","msg":"trace[1896441971] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24612; }","duration":"158.424046ms","start":"2026-05-30T06:04:56.839159Z","end":"2026-05-30T06:04:56.997583Z","steps":["trace[1896441971] 'range keys from in-memory index tree'  (duration: 157.769503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:57.250144Z","caller":"traceutil/trace.go:171","msg":"trace[1136213880] linearizableReadLoop","detail":"{readStateIndex:25427; appliedIndex:25426; }","duration":"247.864748ms","start":"2026-05-30T06:04:57.002241Z","end":"2026-05-30T06:04:57.250105Z","steps":["trace[1136213880] 'read index received'  (duration: 247.597553ms)","trace[1136213880] 'applied index is now lower than readState.Index'  (duration: 265.945µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:57.250304Z","caller":"traceutil/trace.go:171","msg":"trace[153924927] transaction","detail":"{read_only:false; response_revision:24613; number_of_response:1; }","duration":"248.182963ms","start":"2026-05-30T06:04:57.002105Z","end":"2026-05-30T06:04:57.250288Z","steps":["trace[153924927] 'process raft request'  (duration: 247.766956ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:57.250568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.297056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-30T06:04:57.250613Z","caller":"traceutil/trace.go:171","msg":"trace[490692294] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24613; }","duration":"248.392439ms","start":"2026-05-30T06:04:57.002208Z","end":"2026-05-30T06:04:57.2506Z","steps":["trace[490692294] 'agreement among raft nodes before linearized reading'  (duration: 248.187764ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:57.263495Z","caller":"traceutil/trace.go:171","msg":"trace[457292673] transaction","detail":"{read_only:false; response_revision:24614; number_of_response:1; }","duration":"258.848916ms","start":"2026-05-30T06:04:57.00462Z","end":"2026-05-30T06:04:57.263469Z","steps":["trace[457292673] 'process raft request'  (duration: 258.400177ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:57.263747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.007074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-30T06:04:57.263787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.849926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-30T06:04:57.263853Z","caller":"traceutil/trace.go:171","msg":"trace[341927616] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:24614; }","duration":"116.190978ms","start":"2026-05-30T06:04:57.147635Z","end":"2026-05-30T06:04:57.263826Z","steps":["trace[341927616] 'agreement among raft nodes before linearized reading'  (duration: 115.992944ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:57.263886Z","caller":"traceutil/trace.go:171","msg":"trace[1621254183] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:24614; }","duration":"204.003218ms","start":"2026-05-30T06:04:57.059862Z","end":"2026-05-30T06:04:57.263865Z","steps":["trace[1621254183] 'agreement among raft nodes before linearized reading'  (duration: 203.774954ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:57.589887Z","caller":"traceutil/trace.go:171","msg":"trace[1694159640] linearizableReadLoop","detail":"{readStateIndex:25429; appliedIndex:25428; }","duration":"259.808334ms","start":"2026-05-30T06:04:57.330042Z","end":"2026-05-30T06:04:57.589851Z","steps":["trace[1694159640] 'read index received'  (duration: 213.515759ms)","trace[1694159640] 'applied index is now lower than readState.Index'  (duration: 46.288995ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:57.590057Z","caller":"traceutil/trace.go:171","msg":"trace[193246356] transaction","detail":"{read_only:false; response_revision:24615; number_of_response:1; }","duration":"293.38712ms","start":"2026-05-30T06:04:57.296653Z","end":"2026-05-30T06:04:57.59004Z","steps":["trace[193246356] 'process raft request'  (duration: 246.88718ms)","trace[193246356] 'compare'  (duration: 45.643153ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:57.589867Z","caller":"traceutil/trace.go:171","msg":"trace[598618096] transaction","detail":"{read_only:false; response_revision:24616; number_of_response:1; }","duration":"216.144469ms","start":"2026-05-30T06:04:57.373685Z","end":"2026-05-30T06:04:57.58983Z","steps":["trace[598618096] 'process raft request'  (duration: 216.016827ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:57.590242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.780311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-30T06:04:57.590296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.206871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:57.59036Z","caller":"traceutil/trace.go:171","msg":"trace[2029519952] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:24616; }","duration":"206.970595ms","start":"2026-05-30T06:04:57.383361Z","end":"2026-05-30T06:04:57.590332Z","steps":["trace[2029519952] 'agreement among raft nodes before linearized reading'  (duration: 206.752861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:57.590415Z","caller":"traceutil/trace.go:171","msg":"trace[694191319] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24616; }","duration":"260.403535ms","start":"2026-05-30T06:04:57.329985Z","end":"2026-05-30T06:04:57.590388Z","steps":["trace[694191319] 'agreement among raft nodes before linearized reading'  (duration: 260.14024ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.061097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.878557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:04:58.061214Z","caller":"traceutil/trace.go:171","msg":"trace[1034641763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24616; }","duration":"341.06163ms","start":"2026-05-30T06:04:57.720126Z","end":"2026-05-30T06:04:58.061187Z","steps":["trace[1034641763] 'range keys from in-memory index tree'  (duration: 340.736994ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.061269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:57.720107Z","time spent":"341.151102ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-30T06:04:58.06129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.223323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-30T06:04:58.061555Z","caller":"traceutil/trace.go:171","msg":"trace[571711806] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:24616; }","duration":"360.490929ms","start":"2026-05-30T06:04:57.700945Z","end":"2026-05-30T06:04:58.061436Z","steps":["trace[571711806] 'range keys from in-memory index tree'  (duration: 359.971928ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.061635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:57.700914Z","time spent":"360.700752ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/199.204.45.89\" "}
{"level":"warn","ts":"2026-05-30T06:04:58.061867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.733513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-30T06:04:58.06199Z","caller":"traceutil/trace.go:171","msg":"trace[400582717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24616; }","duration":"341.899597ms","start":"2026-05-30T06:04:57.720063Z","end":"2026-05-30T06:04:58.061963Z","steps":["trace[400582717] 'range keys from in-memory index tree'  (duration: 341.436478ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.062186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:57.720051Z","time spent":"342.11883ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-30T06:04:58.705825Z","caller":"traceutil/trace.go:171","msg":"trace[5774343] linearizableReadLoop","detail":"{readStateIndex:25434; appliedIndex:25430; }","duration":"632.621196ms","start":"2026-05-30T06:04:58.07318Z","end":"2026-05-30T06:04:58.705801Z","steps":["trace[5774343] 'read index received'  (duration: 264.446352ms)","trace[5774343] 'applied index is now lower than readState.Index'  (duration: 368.173774ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:04:58.706067Z","caller":"traceutil/trace.go:171","msg":"trace[1404253911] transaction","detail":"{read_only:false; response_revision:24619; number_of_response:1; }","duration":"638.593968ms","start":"2026-05-30T06:04:58.06745Z","end":"2026-05-30T06:04:58.706044Z","steps":["trace[1404253911] 'process raft request'  (duration: 638.254992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.706288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.067424Z","time spent":"638.744451ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24603 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-30T06:04:58.70638Z","caller":"traceutil/trace.go:171","msg":"trace[267410614] transaction","detail":"{read_only:false; response_revision:24620; number_of_response:1; }","duration":"445.259402ms","start":"2026-05-30T06:04:58.261115Z","end":"2026-05-30T06:04:58.706374Z","steps":["trace[267410614] 'process raft request'  (duration: 444.61629ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.706428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.261077Z","time spent":"445.322282ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24606 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-30T06:04:58.706345Z","caller":"traceutil/trace.go:171","msg":"trace[222944716] transaction","detail":"{read_only:false; response_revision:24621; number_of_response:1; }","duration":"440.674505ms","start":"2026-05-30T06:04:58.265656Z","end":"2026-05-30T06:04:58.70633Z","steps":["trace[222944716] 'process raft request'  (duration: 440.106065ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:58.70648Z","caller":"traceutil/trace.go:171","msg":"trace[233617021] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"640.220349ms","start":"2026-05-30T06:04:58.06621Z","end":"2026-05-30T06:04:58.706431Z","steps":["trace[233617021] 'process raft request'  (duration: 639.278132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:58.706605Z","caller":"traceutil/trace.go:171","msg":"trace[355548285] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"639.27062ms","start":"2026-05-30T06:04:58.06728Z","end":"2026-05-30T06:04:58.70655Z","steps":["trace[355548285] 'process raft request'  (duration: 638.382064ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.706687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.066177Z","time spent":"640.399733ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24604 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:58.706701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.265646Z","time spent":"440.899459ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24607 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:58.706677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.463451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-05-30T06:04:58.706855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.06726Z","time spent":"639.461934ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24602 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-30T06:04:58.706886Z","caller":"traceutil/trace.go:171","msg":"trace[354874797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24621; }","duration":"633.665645ms","start":"2026-05-30T06:04:58.073172Z","end":"2026-05-30T06:04:58.706838Z","steps":["trace[354874797] 'agreement among raft nodes before linearized reading'  (duration: 633.250747ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.70844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.073137Z","time spent":"635.284676ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-30T06:04:58.785603Z","caller":"traceutil/trace.go:171","msg":"trace[767358265] transaction","detail":"{read_only:false; response_revision:24622; number_of_response:1; }","duration":"446.168749ms","start":"2026-05-30T06:04:58.339384Z","end":"2026-05-30T06:04:58.785552Z","steps":["trace[767358265] 'process raft request'  (duration: 445.825132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:58.785738Z","caller":"traceutil/trace.go:171","msg":"trace[1556635334] transaction","detail":"{read_only:false; response_revision:24623; number_of_response:1; }","duration":"359.179874ms","start":"2026-05-30T06:04:58.426485Z","end":"2026-05-30T06:04:58.785664Z","steps":["trace[1556635334] 'process raft request'  (duration: 358.9485ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.785991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.426446Z","time spent":"359.416558ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24608 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-30T06:04:58.786041Z","caller":"traceutil/trace.go:171","msg":"trace[662019686] transaction","detail":"{read_only:false; response_revision:24625; number_of_response:1; }","duration":"275.687184ms","start":"2026-05-30T06:04:58.510333Z","end":"2026-05-30T06:04:58.78602Z","steps":["trace[662019686] 'process raft request'  (duration: 275.246666ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.786126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.339343Z","time spent":"446.485535ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:24552 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:67 lease:4089724171922904730 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >"}
{"level":"warn","ts":"2026-05-30T06:04:58.786346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.659587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-30T06:04:58.785651Z","caller":"traceutil/trace.go:171","msg":"trace[467354526] transaction","detail":"{read_only:false; response_revision:24624; number_of_response:1; }","duration":"276.810825ms","start":"2026-05-30T06:04:58.508821Z","end":"2026-05-30T06:04:58.785631Z","steps":["trace[467354526] 'process raft request'  (duration: 276.692423ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:04:58.786401Z","caller":"traceutil/trace.go:171","msg":"trace[260223365] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24626; }","duration":"428.764199ms","start":"2026-05-30T06:04:58.35762Z","end":"2026-05-30T06:04:58.786384Z","steps":["trace[260223365] 'agreement among raft nodes before linearized reading'  (duration: 428.676937ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.786688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.357583Z","time spent":"429.028925ms","remote":"127.0.0.1:37786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-30T06:04:58.791983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.200699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:04:58.792071Z","caller":"traceutil/trace.go:171","msg":"trace[1994991960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24626; }","duration":"336.354452ms","start":"2026-05-30T06:04:58.455687Z","end":"2026-05-30T06:04:58.792042Z","steps":["trace[1994991960] 'agreement among raft nodes before linearized reading'  (duration: 330.735156ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.79201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.725943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"warn","ts":"2026-05-30T06:04:58.792109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.455653Z","time spent":"336.448573ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-30T06:04:58.792153Z","caller":"traceutil/trace.go:171","msg":"trace[607298414] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24626; }","duration":"276.913217ms","start":"2026-05-30T06:04:58.515223Z","end":"2026-05-30T06:04:58.792137Z","steps":["trace[607298414] 'agreement among raft nodes before linearized reading'  (duration: 271.155398ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.793062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.081008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-05-30T06:04:58.793188Z","caller":"traceutil/trace.go:171","msg":"trace[1303650886] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:24626; }","duration":"482.260182ms","start":"2026-05-30T06:04:58.310904Z","end":"2026-05-30T06:04:58.793164Z","steps":["trace[1303650886] 'agreement among raft nodes before linearized reading'  (duration: 475.463983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:04:58.793265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:04:58.310885Z","time spent":"482.366053ms","remote":"127.0.0.1:46806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1882,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "}
{"level":"info","ts":"2026-05-30T06:05:02.182313Z","caller":"traceutil/trace.go:171","msg":"trace[874366044] linearizableReadLoop","detail":"{readStateIndex:25549; appliedIndex:25548; }","duration":"182.093014ms","start":"2026-05-30T06:05:02.000184Z","end":"2026-05-30T06:05:02.182277Z","steps":["trace[874366044] 'read index received'  (duration: 181.739568ms)","trace[874366044] 'applied index is now lower than readState.Index'  (duration: 351.576µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:02.182389Z","caller":"traceutil/trace.go:171","msg":"trace[45859915] transaction","detail":"{read_only:false; response_revision:24734; number_of_response:1; }","duration":"221.978589ms","start":"2026-05-30T06:05:01.960372Z","end":"2026-05-30T06:05:02.182351Z","steps":["trace[45859915] 'process raft request'  (duration: 221.660054ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:02.182561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.340948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:05:02.18261Z","caller":"traceutil/trace.go:171","msg":"trace[576004543] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:24734; }","duration":"182.460981ms","start":"2026-05-30T06:05:02.000133Z","end":"2026-05-30T06:05:02.182593Z","steps":["trace[576004543] 'agreement among raft nodes before linearized reading'  (duration: 182.346029ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:02.369227Z","caller":"traceutil/trace.go:171","msg":"trace[1117557277] linearizableReadLoop","detail":"{readStateIndex:25550; appliedIndex:25549; }","duration":"110.874507ms","start":"2026-05-30T06:05:02.25832Z","end":"2026-05-30T06:05:02.369194Z","steps":["trace[1117557277] 'read index received'  (duration: 110.628322ms)","trace[1117557277] 'applied index is now lower than readState.Index'  (duration: 244.545µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:02.369342Z","caller":"traceutil/trace.go:171","msg":"trace[766189995] transaction","detail":"{read_only:false; response_revision:24735; number_of_response:1; }","duration":"165.538771ms","start":"2026-05-30T06:05:02.203764Z","end":"2026-05-30T06:05:02.369303Z","steps":["trace[766189995] 'process raft request'  (duration: 165.218155ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:02.369494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.153152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-05-30T06:05:02.369535Z","caller":"traceutil/trace.go:171","msg":"trace[679173853] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24735; }","duration":"111.264555ms","start":"2026-05-30T06:05:02.258259Z","end":"2026-05-30T06:05:02.369524Z","steps":["trace[679173853] 'agreement among raft nodes before linearized reading'  (duration: 111.05834ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:06.903569Z","caller":"traceutil/trace.go:171","msg":"trace[571386795] transaction","detail":"{read_only:false; response_revision:24793; number_of_response:1; }","duration":"168.12698ms","start":"2026-05-30T06:05:06.735416Z","end":"2026-05-30T06:05:06.903543Z","steps":["trace[571386795] 'process raft request'  (duration: 149.967076ms)","trace[571386795] 'compare'  (duration: 18.032551ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:07.058788Z","caller":"traceutil/trace.go:171","msg":"trace[1097436063] transaction","detail":"{read_only:false; response_revision:24795; number_of_response:1; }","duration":"314.622101ms","start":"2026-05-30T06:05:06.744142Z","end":"2026-05-30T06:05:07.058764Z","steps":["trace[1097436063] 'process raft request'  (duration: 314.540189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.058957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:06.744122Z","time spent":"314.747014ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24767 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-30T06:05:07.059038Z","caller":"traceutil/trace.go:171","msg":"trace[29389523] transaction","detail":"{read_only:false; response_revision:24794; number_of_response:1; }","duration":"322.331116ms","start":"2026-05-30T06:05:06.736637Z","end":"2026-05-30T06:05:07.058968Z","steps":["trace[29389523] 'process raft request'  (duration: 289.575386ms)","trace[29389523] 'compare'  (duration: 32.325063ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:07.059131Z","caller":"traceutil/trace.go:171","msg":"trace[81353316] transaction","detail":"{read_only:false; response_revision:24796; number_of_response:1; }","duration":"248.351547ms","start":"2026-05-30T06:05:06.810741Z","end":"2026-05-30T06:05:07.059093Z","steps":["trace[81353316] 'process raft request'  (duration: 247.98596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:07.059334Z","caller":"traceutil/trace.go:171","msg":"trace[2113341598] transaction","detail":"{read_only:false; response_revision:24797; number_of_response:1; }","duration":"244.621497ms","start":"2026-05-30T06:05:06.814691Z","end":"2026-05-30T06:05:07.059312Z","steps":["trace[2113341598] 'process raft request'  (duration: 244.339542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:07.059294Z","caller":"traceutil/trace.go:171","msg":"trace[277705557] linearizableReadLoop","detail":"{readStateIndex:25612; appliedIndex:25609; }","duration":"314.04077ms","start":"2026-05-30T06:05:06.745221Z","end":"2026-05-30T06:05:07.059262Z","steps":["trace[277705557] 'read index received'  (duration: 140.370755ms)","trace[277705557] 'applied index is now lower than readState.Index'  (duration: 173.668305ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:07.05934Z","caller":"traceutil/trace.go:171","msg":"trace[1531875055] transaction","detail":"{read_only:false; response_revision:24798; number_of_response:1; }","duration":"241.449457ms","start":"2026-05-30T06:05:06.817871Z","end":"2026-05-30T06:05:07.05932Z","steps":["trace[1531875055] 'process raft request'  (duration: 241.328885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.059551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.297334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-05-30T06:05:07.059611Z","caller":"traceutil/trace.go:171","msg":"trace[2135676489] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24798; }","duration":"314.433717ms","start":"2026-05-30T06:05:06.745157Z","end":"2026-05-30T06:05:07.059591Z","steps":["trace[2135676489] 'agreement among raft nodes before linearized reading'  (duration: 314.212013ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.059629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.883299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-30T06:05:07.059654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.519148ms","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-05-30T06:05:07.05967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:06.745132Z","time spent":"314.527778ms","remote":"127.0.0.1:46806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1884,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"info","ts":"2026-05-30T06:05:07.05971Z","caller":"traceutil/trace.go:171","msg":"trace[287216750] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24798; }","duration":"232.60617ms","start":"2026-05-30T06:05:06.827093Z","end":"2026-05-30T06:05:07.059699Z","steps":["trace[287216750] 'agreement among raft nodes before linearized reading'  (duration: 232.425166ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.059757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.760096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-30T06:05:07.059789Z","caller":"traceutil/trace.go:171","msg":"trace[320651778] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24798; }","duration":"238.820266ms","start":"2026-05-30T06:05:06.820959Z","end":"2026-05-30T06:05:07.05978Z","steps":["trace[320651778] 'agreement among raft nodes before linearized reading'  (duration: 238.732815ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.059806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.44633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:05:07.059846Z","caller":"traceutil/trace.go:171","msg":"trace[737086809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24798; }","duration":"302.529412ms","start":"2026-05-30T06:05:06.757306Z","end":"2026-05-30T06:05:07.059835Z","steps":["trace[737086809] 'agreement among raft nodes before linearized reading'  (duration: 302.39856ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.059876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:06.757289Z","time spent":"302.580343ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-30T06:05:07.060067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.542939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-30T06:05:07.060112Z","caller":"traceutil/trace.go:171","msg":"trace[1582125569] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24798; }","duration":"186.629061ms","start":"2026-05-30T06:05:06.873471Z","end":"2026-05-30T06:05:07.0601Z","steps":["trace[1582125569] 'agreement among raft nodes before linearized reading'  (duration: 186.525449ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:07.059672Z","caller":"traceutil/trace.go:171","msg":"trace[16145573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24798; }","duration":"302.96643ms","start":"2026-05-30T06:05:06.756693Z","end":"2026-05-30T06:05:07.059659Z","steps":["trace[16145573] 'agreement among raft nodes before linearized reading'  (duration: 302.809277ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.060215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:06.756679Z","time spent":"303.526261ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-30T06:05:07.060202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:06.736554Z","time spent":"322.695742ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24766 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-30T06:05:07.259716Z","caller":"traceutil/trace.go:171","msg":"trace[395303876] transaction","detail":"{read_only:false; response_revision:24799; number_of_response:1; }","duration":"195.382505ms","start":"2026-05-30T06:05:07.064296Z","end":"2026-05-30T06:05:07.259679Z","steps":["trace[395303876] 'process raft request'  (duration: 143.138717ms)","trace[395303876] 'compare'  (duration: 51.890662ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:07.259723Z","caller":"traceutil/trace.go:171","msg":"trace[1236085159] transaction","detail":"{read_only:false; response_revision:24800; number_of_response:1; }","duration":"193.329376ms","start":"2026-05-30T06:05:07.06636Z","end":"2026-05-30T06:05:07.259689Z","steps":["trace[1236085159] 'process raft request'  (duration: 193.200274ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:07.260147Z","caller":"traceutil/trace.go:171","msg":"trace[986491426] transaction","detail":"{read_only:false; response_revision:24802; number_of_response:1; }","duration":"192.99425ms","start":"2026-05-30T06:05:07.067144Z","end":"2026-05-30T06:05:07.260138Z","steps":["trace[986491426] 'process raft request'  (duration: 192.757935ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:07.260119Z","caller":"traceutil/trace.go:171","msg":"trace[94578890] linearizableReadLoop","detail":"{readStateIndex:25620; appliedIndex:25615; }","duration":"133.285701ms","start":"2026-05-30T06:05:07.126801Z","end":"2026-05-30T06:05:07.260087Z","steps":["trace[94578890] 'read index received'  (duration: 80.836679ms)","trace[94578890] 'applied index is now lower than readState.Index'  (duration: 52.447842ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:07.260119Z","caller":"traceutil/trace.go:171","msg":"trace[1642830615] transaction","detail":"{read_only:false; response_revision:24801; number_of_response:1; }","duration":"193.699963ms","start":"2026-05-30T06:05:07.066352Z","end":"2026-05-30T06:05:07.260052Z","steps":["trace[1642830615] 'process raft request'  (duration: 193.279645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:07.260222Z","caller":"traceutil/trace.go:171","msg":"trace[345125780] transaction","detail":"{read_only:false; response_revision:24803; number_of_response:1; }","duration":"192.496111ms","start":"2026-05-30T06:05:07.06772Z","end":"2026-05-30T06:05:07.260216Z","steps":["trace[345125780] 'process raft request'  (duration: 192.312007ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:07.260458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.625698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-05-30T06:05:07.2605Z","caller":"traceutil/trace.go:171","msg":"trace[1667504999] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24803; }","duration":"133.72272ms","start":"2026-05-30T06:05:07.126761Z","end":"2026-05-30T06:05:07.260483Z","steps":["trace[1667504999] 'agreement among raft nodes before linearized reading'  (duration: 133.493286ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:09.492037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.058493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-30T06:05:09.49221Z","caller":"traceutil/trace.go:171","msg":"trace[2032035107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24835; }","duration":"174.297947ms","start":"2026-05-30T06:05:09.317892Z","end":"2026-05-30T06:05:09.49219Z","steps":["trace[2032035107] 'range keys from in-memory index tree'  (duration: 173.840658ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:35.435041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.462177ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777681575 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25040 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:05:35.435197Z","caller":"traceutil/trace.go:171","msg":"trace[451607954] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"426.290374ms","start":"2026-05-30T06:05:35.008881Z","end":"2026-05-30T06:05:35.435171Z","steps":["trace[451607954] 'process raft request'  (duration: 101.603652ms)","trace[451607954] 'compare'  (duration: 323.878346ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:05:35.435302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:35.008859Z","time spent":"426.400475ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25040 > 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":"info","ts":"2026-05-30T06:05:35.465319Z","caller":"traceutil/trace.go:171","msg":"trace[1255782681] transaction","detail":"{read_only:false; response_revision:25055; number_of_response:1; }","duration":"288.093129ms","start":"2026-05-30T06:05:35.1772Z","end":"2026-05-30T06:05:35.465293Z","steps":["trace[1255782681] 'process raft request'  (duration: 287.948416ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:35.605817Z","caller":"traceutil/trace.go:171","msg":"trace[21325769] transaction","detail":"{read_only:false; response_revision:25056; number_of_response:1; }","duration":"414.972568ms","start":"2026-05-30T06:05:35.190821Z","end":"2026-05-30T06:05:35.605794Z","steps":["trace[21325769] 'process raft request'  (duration: 404.152324ms)","trace[21325769] 'compare'  (duration: 10.461888ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:05:35.605955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:35.190793Z","time spent":"415.097922ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25042 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-30T06:05:35.605962Z","caller":"traceutil/trace.go:171","msg":"trace[349292182] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"414.391878ms","start":"2026-05-30T06:05:35.191556Z","end":"2026-05-30T06:05:35.605948Z","steps":["trace[349292182] 'process raft request'  (duration: 414.167443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:35.60602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:35.191542Z","time spent":"414.447179ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25043 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-30T06:05:35.606229Z","caller":"traceutil/trace.go:171","msg":"trace[774330911] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"414.49981ms","start":"2026-05-30T06:05:35.19172Z","end":"2026-05-30T06:05:35.60622Z","steps":["trace[774330911] 'process raft request'  (duration: 414.188024ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:35.606236Z","caller":"traceutil/trace.go:171","msg":"trace[310545863] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"413.793467ms","start":"2026-05-30T06:05:35.19243Z","end":"2026-05-30T06:05:35.606223Z","steps":["trace[310545863] 'process raft request'  (duration: 413.695245ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:35.606218Z","caller":"traceutil/trace.go:171","msg":"trace[97226010] linearizableReadLoop","detail":"{readStateIndex:25883; appliedIndex:25878; }","duration":"173.374119ms","start":"2026-05-30T06:05:35.432825Z","end":"2026-05-30T06:05:35.606199Z","steps":["trace[97226010] 'read index received'  (duration: 32.366552ms)","trace[97226010] 'applied index is now lower than readState.Index'  (duration: 141.006737ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:05:35.606272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:35.191686Z","time spent":"414.562061ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25044 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-30T06:05:35.606283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:35.192422Z","time spent":"413.835748ms","remote":"127.0.0.1:45190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25045 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-30T06:05:35.606407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.002538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:05:35.60643Z","caller":"traceutil/trace.go:171","msg":"trace[1764280139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25059; }","duration":"167.07965ms","start":"2026-05-30T06:05:35.439344Z","end":"2026-05-30T06:05:35.606424Z","steps":["trace[1764280139] 'agreement among raft nodes before linearized reading'  (duration: 166.985228ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:35.60645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.146041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-30T06:05:35.606407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.961482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-30T06:05:35.606514Z","caller":"traceutil/trace.go:171","msg":"trace[1297894078] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25059; }","duration":"163.113986ms","start":"2026-05-30T06:05:35.443393Z","end":"2026-05-30T06:05:35.606507Z","steps":["trace[1297894078] 'agreement among raft nodes before linearized reading'  (duration: 162.935243ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:35.606492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.653284ms","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-05-30T06:05:35.606467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.14658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-30T06:05:35.606554Z","caller":"traceutil/trace.go:171","msg":"trace[513280158] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25059; }","duration":"173.783817ms","start":"2026-05-30T06:05:35.432757Z","end":"2026-05-30T06:05:35.606541Z","steps":["trace[513280158] 'agreement among raft nodes before linearized reading'  (duration: 173.548272ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:35.606556Z","caller":"traceutil/trace.go:171","msg":"trace[577092887] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25059; }","duration":"169.303812ms","start":"2026-05-30T06:05:35.437242Z","end":"2026-05-30T06:05:35.606546Z","steps":["trace[577092887] 'agreement among raft nodes before linearized reading'  (duration: 169.076428ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:35.606484Z","caller":"traceutil/trace.go:171","msg":"trace[61316265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25059; }","duration":"168.247283ms","start":"2026-05-30T06:05:35.438229Z","end":"2026-05-30T06:05:35.606476Z","steps":["trace[61316265] 'agreement among raft nodes before linearized reading'  (duration: 168.1209ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:35.967483Z","caller":"traceutil/trace.go:171","msg":"trace[641601280] transaction","detail":"{read_only:false; response_revision:25066; number_of_response:1; }","duration":"113.085229ms","start":"2026-05-30T06:05:35.854365Z","end":"2026-05-30T06:05:35.96745Z","steps":["trace[641601280] 'process raft request'  (duration: 108.170006ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:37.616569Z","caller":"traceutil/trace.go:171","msg":"trace[1144668221] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"145.40608ms","start":"2026-05-30T06:05:37.471135Z","end":"2026-05-30T06:05:37.616541Z","steps":["trace[1144668221] 'process raft request'  (duration: 145.223596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:37.83699Z","caller":"traceutil/trace.go:171","msg":"trace[2072493525] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"182.563483ms","start":"2026-05-30T06:05:37.654347Z","end":"2026-05-30T06:05:37.83691Z","steps":["trace[2072493525] 'process raft request'  (duration: 182.322169ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:37.866577Z","caller":"traceutil/trace.go:171","msg":"trace[1567788472] linearizableReadLoop","detail":"{readStateIndex:25898; appliedIndex:25896; }","duration":"185.720703ms","start":"2026-05-30T06:05:37.680836Z","end":"2026-05-30T06:05:37.866556Z","steps":["trace[1567788472] 'read index received'  (duration: 155.894229ms)","trace[1567788472] 'applied index is now lower than readState.Index'  (duration: 29.825354ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:37.866615Z","caller":"traceutil/trace.go:171","msg":"trace[1987220090] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"204.485137ms","start":"2026-05-30T06:05:37.662097Z","end":"2026-05-30T06:05:37.866582Z","steps":["trace[1987220090] 'process raft request'  (duration: 204.306304ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:37.866962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.946726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:05:37.867016Z","caller":"traceutil/trace.go:171","msg":"trace[630339698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25075; }","duration":"186.037238ms","start":"2026-05-30T06:05:37.680962Z","end":"2026-05-30T06:05:37.867Z","steps":["trace[630339698] 'agreement among raft nodes before linearized reading'  (duration: 185.838804ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:37.866996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.114351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-30T06:05:37.867117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.185491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-30T06:05:37.867045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.139091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-30T06:05:37.867147Z","caller":"traceutil/trace.go:171","msg":"trace[1512505914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25075; }","duration":"104.231462ms","start":"2026-05-30T06:05:37.762908Z","end":"2026-05-30T06:05:37.867139Z","steps":["trace[1512505914] 'agreement among raft nodes before linearized reading'  (duration: 104.156421ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:37.86716Z","caller":"traceutil/trace.go:171","msg":"trace[689106297] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:25075; }","duration":"167.316715ms","start":"2026-05-30T06:05:37.69983Z","end":"2026-05-30T06:05:37.867147Z","steps":["trace[689106297] 'agreement among raft nodes before linearized reading'  (duration: 167.06643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:37.867106Z","caller":"traceutil/trace.go:171","msg":"trace[634705150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25075; }","duration":"186.309475ms","start":"2026-05-30T06:05:37.680771Z","end":"2026-05-30T06:05:37.86708Z","steps":["trace[634705150] 'agreement among raft nodes before linearized reading'  (duration: 185.952538ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:37.867272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.073949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"warn","ts":"2026-05-30T06:05:37.867316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.08098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-30T06:05:37.867478Z","caller":"traceutil/trace.go:171","msg":"trace[870031242] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25075; }","duration":"186.318774ms","start":"2026-05-30T06:05:37.681147Z","end":"2026-05-30T06:05:37.867466Z","steps":["trace[870031242] 'agreement among raft nodes before linearized reading'  (duration: 185.890165ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:37.867357Z","caller":"traceutil/trace.go:171","msg":"trace[1323712320] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25075; }","duration":"186.272623ms","start":"2026-05-30T06:05:37.681062Z","end":"2026-05-30T06:05:37.867334Z","steps":["trace[1323712320] 'agreement among raft nodes before linearized reading'  (duration: 185.998858ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:38.126611Z","caller":"traceutil/trace.go:171","msg":"trace[750023852] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"253.042456ms","start":"2026-05-30T06:05:37.873532Z","end":"2026-05-30T06:05:38.126575Z","steps":["trace[750023852] 'process raft request'  (duration: 252.916764ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:38.126626Z","caller":"traceutil/trace.go:171","msg":"trace[2122185720] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"253.077887ms","start":"2026-05-30T06:05:37.873486Z","end":"2026-05-30T06:05:38.126564Z","steps":["trace[2122185720] 'process raft request'  (duration: 252.68181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:38.126913Z","caller":"traceutil/trace.go:171","msg":"trace[489639686] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"253.340192ms","start":"2026-05-30T06:05:37.873541Z","end":"2026-05-30T06:05:38.126881Z","steps":["trace[489639686] 'process raft request'  (duration: 252.981425ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:38.127092Z","caller":"traceutil/trace.go:171","msg":"trace[2041917924] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"253.165018ms","start":"2026-05-30T06:05:37.873912Z","end":"2026-05-30T06:05:38.127077Z","steps":["trace[2041917924] 'process raft request'  (duration: 252.884113ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:38.127224Z","caller":"traceutil/trace.go:171","msg":"trace[1924088388] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"154.122466ms","start":"2026-05-30T06:05:37.973084Z","end":"2026-05-30T06:05:38.127207Z","steps":["trace[1924088388] 'process raft request'  (duration: 154.052284ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:38.127319Z","caller":"traceutil/trace.go:171","msg":"trace[1756257690] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"252.406214ms","start":"2026-05-30T06:05:37.87488Z","end":"2026-05-30T06:05:38.127286Z","steps":["trace[1756257690] 'process raft request'  (duration: 252.148509ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:38.391871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.810476ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777681622 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:25004 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:67 lease:4089724171922905806 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:05:38.39197Z","caller":"traceutil/trace.go:171","msg":"trace[1765636977] linearizableReadLoop","detail":"{readStateIndex:25907; appliedIndex:25906; }","duration":"150.564657ms","start":"2026-05-30T06:05:38.241392Z","end":"2026-05-30T06:05:38.391956Z","steps":["trace[1765636977] 'read index received'  (duration: 46.921µs)","trace[1765636977] 'applied index is now lower than readState.Index'  (duration: 150.516456ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:38.392044Z","caller":"traceutil/trace.go:171","msg":"trace[1454197965] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"328.984532ms","start":"2026-05-30T06:05:38.06305Z","end":"2026-05-30T06:05:38.392035Z","steps":["trace[1454197965] 'process raft request'  (duration: 153.85117ms)","trace[1454197965] 'compare'  (duration: 174.703645ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-30T06:05:38.392099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:38.063025Z","time spent":"329.039524ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:25004 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:67 lease:4089724171922905806 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >"}
{"level":"warn","ts":"2026-05-30T06:05:38.392674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.23872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-30T06:05:38.392756Z","caller":"traceutil/trace.go:171","msg":"trace[1313400040] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:25082; }","duration":"151.398633ms","start":"2026-05-30T06:05:38.24134Z","end":"2026-05-30T06:05:38.392739Z","steps":["trace[1313400040] 'agreement among raft nodes before linearized reading'  (duration: 151.146028ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:38.811465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.853857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"info","ts":"2026-05-30T06:05:38.811581Z","caller":"traceutil/trace.go:171","msg":"trace[798544981] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25082; }","duration":"313.03368ms","start":"2026-05-30T06:05:38.498519Z","end":"2026-05-30T06:05:38.811553Z","steps":["trace[798544981] 'range keys from in-memory index tree'  (duration: 312.599702ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:38.811637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T06:05:38.498476Z","time spent":"313.149383ms","remote":"127.0.0.1:37796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5708,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-30T06:05:39.754303Z","caller":"traceutil/trace.go:171","msg":"trace[1818240462] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"132.624818ms","start":"2026-05-30T06:05:39.621646Z","end":"2026-05-30T06:05:39.754271Z","steps":["trace[1818240462] 'process raft request'  (duration: 132.460035ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:39.793744Z","caller":"traceutil/trace.go:171","msg":"trace[49304817] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"132.090859ms","start":"2026-05-30T06:05:39.661629Z","end":"2026-05-30T06:05:39.79372Z","steps":["trace[49304817] 'process raft request'  (duration: 131.889584ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:39.794025Z","caller":"traceutil/trace.go:171","msg":"trace[1100516497] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"130.043389ms","start":"2026-05-30T06:05:39.663969Z","end":"2026-05-30T06:05:39.794012Z","steps":["trace[1100516497] 'process raft request'  (duration: 129.999928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:39.794085Z","caller":"traceutil/trace.go:171","msg":"trace[365354792] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"131.903565ms","start":"2026-05-30T06:05:39.662133Z","end":"2026-05-30T06:05:39.794036Z","steps":["trace[365354792] 'process raft request'  (duration: 131.536128ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:39.794121Z","caller":"traceutil/trace.go:171","msg":"trace[441210110] transaction","detail":"{read_only:false; response_revision:25087; number_of_response:1; }","duration":"130.474197ms","start":"2026-05-30T06:05:39.663605Z","end":"2026-05-30T06:05:39.794079Z","steps":["trace[441210110] 'process raft request'  (duration: 130.309084ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:40.304227Z","caller":"traceutil/trace.go:171","msg":"trace[556401517] linearizableReadLoop","detail":"{readStateIndex:25915; appliedIndex:25914; }","duration":"171.30349ms","start":"2026-05-30T06:05:40.132892Z","end":"2026-05-30T06:05:40.304196Z","steps":["trace[556401517] 'read index received'  (duration: 171.053815ms)","trace[556401517] 'applied index is now lower than readState.Index'  (duration: 247.925µs)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:40.304386Z","caller":"traceutil/trace.go:171","msg":"trace[544360357] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"171.526314ms","start":"2026-05-30T06:05:40.132844Z","end":"2026-05-30T06:05:40.304371Z","steps":["trace[544360357] 'process raft request'  (duration: 171.134407ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:40.304696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.782338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-30T06:05:40.304769Z","caller":"traceutil/trace.go:171","msg":"trace[1472760486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25090; }","duration":"171.887082ms","start":"2026-05-30T06:05:40.132865Z","end":"2026-05-30T06:05:40.304752Z","steps":["trace[1472760486] 'agreement among raft nodes before linearized reading'  (duration: 171.662777ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:40.315961Z","caller":"traceutil/trace.go:171","msg":"trace[1618070275] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"180.863212ms","start":"2026-05-30T06:05:40.135051Z","end":"2026-05-30T06:05:40.315914Z","steps":["trace[1618070275] 'process raft request'  (duration: 180.626547ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:40.315964Z","caller":"traceutil/trace.go:171","msg":"trace[252533321] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"178.12583ms","start":"2026-05-30T06:05:40.137811Z","end":"2026-05-30T06:05:40.315937Z","steps":["trace[252533321] 'process raft request'  (duration: 178.017067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:40.316158Z","caller":"traceutil/trace.go:171","msg":"trace[1770792115] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"177.963827ms","start":"2026-05-30T06:05:40.138157Z","end":"2026-05-30T06:05:40.31612Z","steps":["trace[1770792115] 'process raft request'  (duration: 177.724781ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:40.316276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.993253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-30T06:05:40.316367Z","caller":"traceutil/trace.go:171","msg":"trace[1550728221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25093; }","duration":"182.124655ms","start":"2026-05-30T06:05:40.134227Z","end":"2026-05-30T06:05:40.316351Z","steps":["trace[1550728221] 'agreement among raft nodes before linearized reading'  (duration: 181.86275ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:05:40.442888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.935616ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313096208777681663 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25079 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-30T06:05:40.443106Z","caller":"traceutil/trace.go:171","msg":"trace[1218137662] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"132.367043ms","start":"2026-05-30T06:05:40.310651Z","end":"2026-05-30T06:05:40.443018Z","steps":["trace[1218137662] 'process raft request'  (duration: 19.179892ms)","trace[1218137662] 'compare'  (duration: 112.733533ms)"],"step_count":2}
{"level":"info","ts":"2026-05-30T06:05:40.458387Z","caller":"traceutil/trace.go:171","msg":"trace[466383536] transaction","detail":"{read_only:false; response_revision:25095; number_of_response:1; }","duration":"136.324548ms","start":"2026-05-30T06:05:40.322035Z","end":"2026-05-30T06:05:40.45836Z","steps":["trace[466383536] 'process raft request'  (duration: 136.164255ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:05:43.743016Z","caller":"traceutil/trace.go:171","msg":"trace[159755801] transaction","detail":"{read_only:false; response_revision:25111; number_of_response:1; }","duration":"151.350933ms","start":"2026-05-30T06:05:43.591628Z","end":"2026-05-30T06:05:43.742978Z","steps":["trace[159755801] 'process raft request'  (duration: 151.040087ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:06:02.093941Z","caller":"traceutil/trace.go:171","msg":"trace[1158874991] transaction","detail":"{read_only:false; response_revision:25257; number_of_response:1; }","duration":"101.394258ms","start":"2026-05-30T06:06:01.992519Z","end":"2026-05-30T06:06:02.093914Z","steps":["trace[1158874991] 'process raft request'  (duration: 96.632747ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:06:02.094276Z","caller":"traceutil/trace.go:171","msg":"trace[227658058] transaction","detail":"{read_only:false; response_revision:25258; number_of_response:1; }","duration":"101.722514ms","start":"2026-05-30T06:06:01.992514Z","end":"2026-05-30T06:06:02.094236Z","steps":["trace[227658058] 'process raft request'  (duration: 101.344087ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:06:02.094399Z","caller":"traceutil/trace.go:171","msg":"trace[1825181243] transaction","detail":"{read_only:false; response_revision:25259; number_of_response:1; }","duration":"101.677333ms","start":"2026-05-30T06:06:01.992688Z","end":"2026-05-30T06:06:02.094365Z","steps":["trace[1825181243] 'process raft request'  (duration: 101.441839ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-30T06:06:07.728149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.633653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-30T06:06:07.728268Z","caller":"traceutil/trace.go:171","msg":"trace[779901187] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:25298; }","duration":"101.844546ms","start":"2026-05-30T06:06:07.626398Z","end":"2026-05-30T06:06:07.728243Z","steps":["trace[779901187] 'count revisions from in-memory index tree'  (duration: 101.482249ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:06:13.13398Z","caller":"traceutil/trace.go:171","msg":"trace[773215476] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"118.655884ms","start":"2026-05-30T06:06:13.015264Z","end":"2026-05-30T06:06:13.13392Z","steps":["trace[773215476] 'process raft request'  (duration: 118.265206ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:07:10.675672Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000689e.wal"}
{"level":"info","ts":"2026-05-30T06:07:24.541851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23210}
{"level":"info","ts":"2026-05-30T06:07:24.685131Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23210,"took":"137.855178ms","hash":2272152798,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":36347904,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-30T06:07:24.685225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2272152798,"revision":23210,"compact-revision":19979}
{"level":"info","ts":"2026-05-30T06:09:19.672602Z","caller":"traceutil/trace.go:171","msg":"trace[578340797] transaction","detail":"{read_only:false; response_revision:27212; number_of_response:1; }","duration":"195.934986ms","start":"2026-05-30T06:09:19.476617Z","end":"2026-05-30T06:09:19.672552Z","steps":["trace[578340797] 'process raft request'  (duration: 195.672211ms)"],"step_count":1}
{"level":"info","ts":"2026-05-30T06:12:24.548231Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26083}
{"level":"info","ts":"2026-05-30T06:12:24.695119Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26083,"took":"141.265343ms","hash":1639978240,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":34164736,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-30T06:12:24.695238Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1639978240,"revision":26083,"compact-revision":23210}
{"level":"info","ts":"2026-05-30T06:13:11.15955Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-30T06:13:11.165584Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-30T06:13:11.165884Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-30T06:17:24.555727Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28728}
{"level":"info","ts":"2026-05-30T06:17:24.695509Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28728,"took":"134.943843ms","hash":1490744535,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":30138368,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-30T06:17:24.695572Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1490744535,"revision":28728,"compact-revision":26083}
{"level":"info","ts":"2026-05-30T06:22:24.561825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30943}
{"level":"info","ts":"2026-05-30T06:22:24.681488Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30943,"took":"115.795652ms","hash":4198171687,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":30986240,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-30T06:22:24.681572Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4198171687,"revision":30943,"compact-revision":28728}
{"level":"info","ts":"2026-05-30T06:27:24.570776Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33212}
{"level":"info","ts":"2026-05-30T06:27:24.71774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33212,"took":"142.242552ms","hash":1878825878,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":31637504,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-30T06:27:24.717822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1878825878,"revision":33212,"compact-revision":30943}
{"level":"info","ts":"2026-05-30T06:32:24.579537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35504}
{"level":"info","ts":"2026-05-30T06:32:24.723666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35504,"took":"138.437431ms","hash":3120659880,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":31014912,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-30T06:32:24.72376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3120659880,"revision":35504,"compact-revision":33212}
{"level":"info","ts":"2026-05-30T06:34:42.828164Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-30T06:34:42.833598Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-30T06:34:42.833845Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-30T06:37:24.58636Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37727}
{"level":"info","ts":"2026-05-30T06:37:24.71306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37727,"took":"119.131235ms","hash":3826337906,"current-db-size-bytes":58744832,"current-db-size":"59 MB","current-db-size-in-use-bytes":31862784,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-30T06:37:24.713128Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3826337906,"revision":37727,"compact-revision":35504}