{"level":"warn","ts":"2026-08-14T09:23:01.041439Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-14T09:23:01.041564Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.125: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.19.213.125:2380","--initial-cluster=instance=https://199.19.213.125:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.125:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.125: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-08-14T09:23:01.041648Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-14T09:23:01.041663Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.125:2380"]}
{"level":"info","ts":"2026-08-14T09:23:01.041684Z","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-08-14T09:23:01.042442Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"]}
{"level":"info","ts":"2026-08-14T09:23:01.042527Z","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.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.125: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-08-14T09:23:01.046107Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.3143ms"}
{"level":"info","ts":"2026-08-14T09:23:01.05212Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b448fdce642f2755","cluster-id":"66f7e5dc9a72c5e3"}
{"level":"info","ts":"2026-08-14T09:23:01.052266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-14T09:23:01.052303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 0"}
{"level":"info","ts":"2026-08-14T09:23:01.052327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b448fdce642f2755 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-14T09:23:01.052343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 1"}
{"level":"info","ts":"2026-08-14T09:23:01.052405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"}
{"level":"warn","ts":"2026-08-14T09:23:01.060354Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-14T09:23:01.062374Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-14T09:23:01.063933Z","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-08-14T09:23:01.067602Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b448fdce642f2755","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-14T09:23:01.068342Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b448fdce642f2755","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-14T09:23:01.068874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"}
{"level":"info","ts":"2026-08-14T09:23:01.069095Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","added-peer-id":"b448fdce642f2755","added-peer-peer-urls":["https://199.19.213.125:2380"]}
{"level":"info","ts":"2026-08-14T09:23:01.069173Z","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-08-14T09:23:01.069263Z","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-08-14T09:23:01.069276Z","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-08-14T09:23:01.077123Z","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-08-14T09:23:01.077688Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.125:2380"}
{"level":"info","ts":"2026-08-14T09:23:01.077813Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.125:2380"}
{"level":"info","ts":"2026-08-14T09:23:01.07805Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b448fdce642f2755","initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-14T09:23:01.078114Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-14T09:23:01.852853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-14T09:23:01.852921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-14T09:23:01.85294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgPreVoteResp from b448fdce642f2755 at term 1"}
{"level":"info","ts":"2026-08-14T09:23:01.852957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became candidate at term 2"}
{"level":"info","ts":"2026-08-14T09:23:01.852965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgVoteResp from b448fdce642f2755 at term 2"}
{"level":"info","ts":"2026-08-14T09:23:01.852976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became leader at term 2"}
{"level":"info","ts":"2026-08-14T09:23:01.852986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b448fdce642f2755 elected leader b448fdce642f2755 at term 2"}
{"level":"info","ts":"2026-08-14T09:23:01.85405Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:23:01.855059Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-14T09:23:01.855052Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b448fdce642f2755","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.125:2379]}","request-path":"/0/members/b448fdce642f2755/attributes","cluster-id":"66f7e5dc9a72c5e3","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-14T09:23:01.855115Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-14T09:23:01.855398Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:23:01.855542Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:23:01.855576Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-14T09:23:01.855488Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-14T09:23:01.855657Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-14T09:23:01.85772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-14T09:23:01.858066Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.125:2379"}
{"level":"info","ts":"2026-08-14T09:23:47.144805Z","caller":"traceutil/trace.go:171","msg":"trace[1129253192] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"233.066316ms","start":"2026-08-14T09:23:46.911701Z","end":"2026-08-14T09:23:47.144767Z","steps":["trace[1129253192] 'process raft request'  (duration: 232.329818ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:23:47.785667Z","caller":"traceutil/trace.go:171","msg":"trace[353748856] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"111.012552ms","start":"2026-08-14T09:23:47.674609Z","end":"2026-08-14T09:23:47.785622Z","steps":["trace[353748856] 'process raft request'  (duration: 102.968725ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:24:02.61787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.718917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-08-14T09:24:02.617866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.307504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-14T09:24:02.618018Z","caller":"traceutil/trace.go:171","msg":"trace[1843194333] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:759; }","duration":"266.423974ms","start":"2026-08-14T09:24:02.351572Z","end":"2026-08-14T09:24:02.617996Z","steps":["trace[1843194333] 'range keys from in-memory index tree'  (duration: 265.355399ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:24:02.618061Z","caller":"traceutil/trace.go:171","msg":"trace[52403009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:759; }","duration":"126.217456ms","start":"2026-08-14T09:24:02.49181Z","end":"2026-08-14T09:24:02.618028Z","steps":["trace[52403009] 'range keys from in-memory index tree'  (duration: 125.083908ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:24:52.672163Z","caller":"traceutil/trace.go:171","msg":"trace[863982932] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"147.718847ms","start":"2026-08-14T09:24:52.524422Z","end":"2026-08-14T09:24:52.672141Z","steps":["trace[863982932] 'process raft request'  (duration: 147.577023ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:25:17.866935Z","caller":"traceutil/trace.go:171","msg":"trace[1626873731] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"379.303315ms","start":"2026-08-14T09:25:17.487593Z","end":"2026-08-14T09:25:17.866897Z","steps":["trace[1626873731] 'process raft request'  (duration: 339.46815ms)","trace[1626873731] 'compare'  (duration: 39.653491ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:25:17.86758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:25:17.487553Z","time spent":"379.49575ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1760 > 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-08-14T09:25:17.880704Z","caller":"traceutil/trace.go:171","msg":"trace[1106671131] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1898; }","duration":"265.648593ms","start":"2026-08-14T09:25:17.615029Z","end":"2026-08-14T09:25:17.880678Z","steps":["trace[1106671131] 'read index received'  (duration: 212.052721ms)","trace[1106671131] 'applied index is now lower than readState.Index'  (duration: 53.594692ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:25:17.880732Z","caller":"traceutil/trace.go:171","msg":"trace[1255475542] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"374.138949ms","start":"2026-08-14T09:25:17.506572Z","end":"2026-08-14T09:25:17.880711Z","steps":["trace[1255475542] 'process raft request'  (duration: 373.968335ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:25:17.880834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:25:17.506542Z","time spent":"374.254941ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1764 > 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-08-14T09:25:17.880958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.89774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d376187-07db-4450-ac03-f21f27884ba1\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-14T09:25:17.881031Z","caller":"traceutil/trace.go:171","msg":"trace[2034523506] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d376187-07db-4450-ac03-f21f27884ba1; range_end:; response_count:1; response_revision:1829; }","duration":"266.036893ms","start":"2026-08-14T09:25:17.614975Z","end":"2026-08-14T09:25:17.881012Z","steps":["trace[2034523506] 'agreement among raft nodes before linearized reading'  (duration: 265.819218ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:25:18.044398Z","caller":"traceutil/trace.go:171","msg":"trace[1252231169] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"155.555919ms","start":"2026-08-14T09:25:17.88881Z","end":"2026-08-14T09:25:18.044366Z","steps":["trace[1252231169] 'process raft request'  (duration: 133.188731ms)","trace[1252231169] 'compare'  (duration: 22.059379ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:25:18.411068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.500158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-14T09:25:18.411183Z","caller":"traceutil/trace.go:171","msg":"trace[983391048] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1830; }","duration":"189.699504ms","start":"2026-08-14T09:25:18.221459Z","end":"2026-08-14T09:25:18.411159Z","steps":["trace[983391048] 'count revisions from in-memory index tree'  (duration: 189.378005ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:25:18.411069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.085006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:25:18.411247Z","caller":"traceutil/trace.go:171","msg":"trace[1490917406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1830; }","duration":"155.305092ms","start":"2026-08-14T09:25:18.255919Z","end":"2026-08-14T09:25:18.411224Z","steps":["trace[1490917406] 'range keys from in-memory index tree'  (duration: 154.926432ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:25:31.618988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.510545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-14T09:25:31.619087Z","caller":"traceutil/trace.go:171","msg":"trace[1938739818] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1944; }","duration":"101.677289ms","start":"2026-08-14T09:25:31.517387Z","end":"2026-08-14T09:25:31.619064Z","steps":["trace[1938739818] 'range keys from in-memory index tree'  (duration: 101.289019ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:08.296071Z","caller":"traceutil/trace.go:171","msg":"trace[1947965207] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"142.079671ms","start":"2026-08-14T09:26:08.153955Z","end":"2026-08-14T09:26:08.296035Z","steps":["trace[1947965207] 'read index received'  (duration: 141.867746ms)","trace[1947965207] 'applied index is now lower than readState.Index'  (duration: 210.465µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:26:08.296205Z","caller":"traceutil/trace.go:171","msg":"trace[1699260863] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"189.561012ms","start":"2026-08-14T09:26:08.106573Z","end":"2026-08-14T09:26:08.296134Z","steps":["trace[1699260863] 'process raft request'  (duration: 189.224704ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:26:08.296424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.446621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-14T09:26:08.296498Z","caller":"traceutil/trace.go:171","msg":"trace[1401311499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2158; }","duration":"142.548543ms","start":"2026-08-14T09:26:08.153932Z","end":"2026-08-14T09:26:08.296481Z","steps":["trace[1401311499] 'agreement among raft nodes before linearized reading'  (duration: 142.296287ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:08.413207Z","caller":"traceutil/trace.go:171","msg":"trace[827407449] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"111.284779ms","start":"2026-08-14T09:26:08.301883Z","end":"2026-08-14T09:26:08.413168Z","steps":["trace[827407449] 'process raft request'  (duration: 106.749578ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:14.443539Z","caller":"traceutil/trace.go:171","msg":"trace[1200949729] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"123.501527ms","start":"2026-08-14T09:26:14.319991Z","end":"2026-08-14T09:26:14.443492Z","steps":["trace[1200949729] 'process raft request'  (duration: 123.116118ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:22.478441Z","caller":"traceutil/trace.go:171","msg":"trace[1088558716] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"115.805699ms","start":"2026-08-14T09:26:22.362604Z","end":"2026-08-14T09:26:22.478409Z","steps":["trace[1088558716] 'process raft request'  (duration: 70.245396ms)","trace[1088558716] 'compare'  (duration: 45.346688ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:26:22.478875Z","caller":"traceutil/trace.go:171","msg":"trace[914824271] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"116.23661ms","start":"2026-08-14T09:26:22.362595Z","end":"2026-08-14T09:26:22.478832Z","steps":["trace[914824271] 'process raft request'  (duration: 115.764608ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:22.478959Z","caller":"traceutil/trace.go:171","msg":"trace[1252926066] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"116.165438ms","start":"2026-08-14T09:26:22.362757Z","end":"2026-08-14T09:26:22.478923Z","steps":["trace[1252926066] 'process raft request'  (duration: 115.930873ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:22.479022Z","caller":"traceutil/trace.go:171","msg":"trace[1837383226] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"104.977365ms","start":"2026-08-14T09:26:22.374021Z","end":"2026-08-14T09:26:22.478998Z","steps":["trace[1837383226] 'process raft request'  (duration: 104.826382ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:26:22.478967Z","caller":"traceutil/trace.go:171","msg":"trace[1059360023] linearizableReadLoop","detail":"{readStateIndex:2324; appliedIndex:2320; }","duration":"100.157687ms","start":"2026-08-14T09:26:22.378769Z","end":"2026-08-14T09:26:22.478927Z","steps":["trace[1059360023] 'read index received'  (duration: 54.00624ms)","trace[1059360023] 'applied index is now lower than readState.Index'  (duration: 46.149827ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:26:22.479247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.456734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-08-14T09:26:22.479324Z","caller":"traceutil/trace.go:171","msg":"trace[164448192] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2238; }","duration":"100.574718ms","start":"2026-08-14T09:26:22.37873Z","end":"2026-08-14T09:26:22.479305Z","steps":["trace[164448192] 'agreement among raft nodes before linearized reading'  (duration: 100.299311ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:27:03.949644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.587689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-14T09:27:03.949741Z","caller":"traceutil/trace.go:171","msg":"trace[1332889207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2629; }","duration":"267.747243ms","start":"2026-08-14T09:27:03.681974Z","end":"2026-08-14T09:27:03.949721Z","steps":["trace[1332889207] 'range keys from in-memory index tree'  (duration: 267.404005ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:27:03.950299Z","caller":"traceutil/trace.go:171","msg":"trace[33419629] linearizableReadLoop","detail":"{readStateIndex:2730; appliedIndex:2729; }","duration":"123.760004ms","start":"2026-08-14T09:27:03.82653Z","end":"2026-08-14T09:27:03.95029Z","steps":["trace[33419629] 'read index received'  (duration: 123.590119ms)","trace[33419629] 'applied index is now lower than readState.Index'  (duration: 169.305µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:27:03.950388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.852406ms","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:5"}
{"level":"info","ts":"2026-08-14T09:27:03.95041Z","caller":"traceutil/trace.go:171","msg":"trace[2057968194] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2630; }","duration":"123.910608ms","start":"2026-08-14T09:27:03.82649Z","end":"2026-08-14T09:27:03.950401Z","steps":["trace[2057968194] 'agreement among raft nodes before linearized reading'  (duration: 123.838526ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:27:03.950402Z","caller":"traceutil/trace.go:171","msg":"trace[208267567] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"267.061768ms","start":"2026-08-14T09:27:03.683289Z","end":"2026-08-14T09:27:03.950351Z","steps":["trace[208267567] 'process raft request'  (duration: 266.887473ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:27:37.963853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.562919ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564439909 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2822 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-14T09:27:37.963973Z","caller":"traceutil/trace.go:171","msg":"trace[1134869133] linearizableReadLoop","detail":"{readStateIndex:2941; appliedIndex:2940; }","duration":"111.8178ms","start":"2026-08-14T09:27:37.852138Z","end":"2026-08-14T09:27:37.963956Z","steps":["trace[1134869133] 'read index received'  (duration: 110.233µs)","trace[1134869133] 'applied index is now lower than readState.Index'  (duration: 111.706137ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:27:37.964069Z","caller":"traceutil/trace.go:171","msg":"trace[157688606] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"263.450598ms","start":"2026-08-14T09:27:37.700607Z","end":"2026-08-14T09:27:37.964058Z","steps":["trace[157688606] 'process raft request'  (duration: 130.440658ms)","trace[157688606] 'compare'  (duration: 132.371465ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:27:37.96434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.882356ms","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-08-14T09:27:37.964458Z","caller":"traceutil/trace.go:171","msg":"trace[809966204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2833; }","duration":"109.04787ms","start":"2026-08-14T09:27:37.855379Z","end":"2026-08-14T09:27:37.964427Z","steps":["trace[809966204] 'agreement among raft nodes before linearized reading'  (duration: 108.765233ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:27:37.964449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.316302ms","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-08-14T09:27:37.964609Z","caller":"traceutil/trace.go:171","msg":"trace[390695184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2833; }","duration":"112.485587ms","start":"2026-08-14T09:27:37.852065Z","end":"2026-08-14T09:27:37.964551Z","steps":["trace[390695184] 'agreement among raft nodes before linearized reading'  (duration: 112.091927ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:27:38.169648Z","caller":"traceutil/trace.go:171","msg":"trace[1938422874] transaction","detail":"{read_only:false; response_revision:2835; number_of_response:1; }","duration":"199.302911ms","start":"2026-08-14T09:27:37.970309Z","end":"2026-08-14T09:27:38.169612Z","steps":["trace[1938422874] 'process raft request'  (duration: 199.24746ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:27:38.169725Z","caller":"traceutil/trace.go:171","msg":"trace[1272067439] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"199.614669ms","start":"2026-08-14T09:27:37.970072Z","end":"2026-08-14T09:27:38.169686Z","steps":["trace[1272067439] 'process raft request'  (duration: 127.384663ms)","trace[1272067439] 'compare'  (duration: 71.911868ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:27:43.640526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.623592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:27:43.640602Z","caller":"traceutil/trace.go:171","msg":"trace[1689952895] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2866; }","duration":"132.728814ms","start":"2026-08-14T09:27:43.507854Z","end":"2026-08-14T09:27:43.640583Z","steps":["trace[1689952895] 'count revisions from in-memory index tree'  (duration: 132.423486ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:27:43.962045Z","caller":"traceutil/trace.go:171","msg":"trace[1296509394] linearizableReadLoop","detail":"{readStateIndex:2976; appliedIndex:2975; }","duration":"235.747846ms","start":"2026-08-14T09:27:43.726266Z","end":"2026-08-14T09:27:43.962014Z","steps":["trace[1296509394] 'read index received'  (duration: 235.546151ms)","trace[1296509394] 'applied index is now lower than readState.Index'  (duration: 200.375µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:27:43.962106Z","caller":"traceutil/trace.go:171","msg":"trace[233317738] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"280.594219ms","start":"2026-08-14T09:27:43.681471Z","end":"2026-08-14T09:27:43.962065Z","steps":["trace[233317738] 'process raft request'  (duration: 280.344173ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:27:43.962224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.941701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:27:43.96229Z","caller":"traceutil/trace.go:171","msg":"trace[443578382] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2867; }","duration":"236.066945ms","start":"2026-08-14T09:27:43.726207Z","end":"2026-08-14T09:27:43.962274Z","steps":["trace[443578382] 'agreement among raft nodes before linearized reading'  (duration: 235.931371ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:31:53.376382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.900554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:31:53.376521Z","caller":"traceutil/trace.go:171","msg":"trace[222508186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5094; }","duration":"121.114909ms","start":"2026-08-14T09:31:53.255377Z","end":"2026-08-14T09:31:53.376492Z","steps":["trace[222508186] 'range keys from in-memory index tree'  (duration: 120.600056ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:31:53.491317Z","caller":"traceutil/trace.go:171","msg":"trace[778929419] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"109.757882ms","start":"2026-08-14T09:31:53.381507Z","end":"2026-08-14T09:31:53.491264Z","steps":["trace[778929419] 'process raft request'  (duration: 109.430754ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:32:08.386344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.546534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-14T09:32:08.38667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.168234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:70863"}
{"level":"info","ts":"2026-08-14T09:32:08.386772Z","caller":"traceutil/trace.go:171","msg":"trace[1945517434] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5385; }","duration":"237.332178ms","start":"2026-08-14T09:32:08.149418Z","end":"2026-08-14T09:32:08.386751Z","steps":["trace[1945517434] 'range keys from in-memory index tree'  (duration: 236.805035ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:32:08.386711Z","caller":"traceutil/trace.go:171","msg":"trace[1348794563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5385; }","duration":"132.012955ms","start":"2026-08-14T09:32:08.25467Z","end":"2026-08-14T09:32:08.386683Z","steps":["trace[1348794563] 'range keys from in-memory index tree'  (duration: 131.402231ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:32:08.72165Z","caller":"traceutil/trace.go:171","msg":"trace[2128921642] linearizableReadLoop","detail":"{readStateIndex:5587; appliedIndex:5586; }","duration":"169.3864ms","start":"2026-08-14T09:32:08.552237Z","end":"2026-08-14T09:32:08.721623Z","steps":["trace[2128921642] 'read index received'  (duration: 169.178405ms)","trace[2128921642] 'applied index is now lower than readState.Index'  (duration: 206.315µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:32:08.721853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.583104ms","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:5"}
{"level":"info","ts":"2026-08-14T09:32:08.721957Z","caller":"traceutil/trace.go:171","msg":"trace[355237336] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5386; }","duration":"169.788999ms","start":"2026-08-14T09:32:08.552148Z","end":"2026-08-14T09:32:08.721937Z","steps":["trace[355237336] 'agreement among raft nodes before linearized reading'  (duration: 169.596115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:32:08.722394Z","caller":"traceutil/trace.go:171","msg":"trace[1605989595] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"257.117292ms","start":"2026-08-14T09:32:08.464574Z","end":"2026-08-14T09:32:08.721691Z","steps":["trace[1605989595] 'process raft request'  (duration: 256.856256ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:33:01.881546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2965}
{"level":"info","ts":"2026-08-14T09:33:01.949611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2965,"took":"66.121316ms","hash":2707793528,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":33505280,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-14T09:33:01.949678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2707793528,"revision":2965,"compact-revision":-1}
{"level":"info","ts":"2026-08-14T09:38:01.890963Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6001}
{"level":"info","ts":"2026-08-14T09:38:01.98606Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6001,"took":"92.492312ms","hash":1842056239,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":21839872,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-08-14T09:38:01.986166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1842056239,"revision":6001,"compact-revision":2965}
{"level":"info","ts":"2026-08-14T09:38:28.993923Z","caller":"traceutil/trace.go:171","msg":"trace[598265310] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"141.41938ms","start":"2026-08-14T09:38:28.85247Z","end":"2026-08-14T09:38:28.99389Z","steps":["trace[598265310] 'process raft request'  (duration: 141.221805ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:38:36.705425Z","caller":"traceutil/trace.go:171","msg":"trace[756305405] transaction","detail":"{read_only:false; response_revision:8445; number_of_response:1; }","duration":"102.680981ms","start":"2026-08-14T09:38:36.602719Z","end":"2026-08-14T09:38:36.7054Z","steps":["trace[756305405] 'process raft request'  (duration: 102.529587ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:38:49.536505Z","caller":"traceutil/trace.go:171","msg":"trace[167913092] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"179.037329ms","start":"2026-08-14T09:38:49.357407Z","end":"2026-08-14T09:38:49.536445Z","steps":["trace[167913092] 'process raft request'  (duration: 178.64999ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:39:15.533648Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002337.wal"}
{"level":"info","ts":"2026-08-14T09:39:19.748851Z","caller":"traceutil/trace.go:171","msg":"trace[1161081839] transaction","detail":"{read_only:false; response_revision:8731; number_of_response:1; }","duration":"172.370395ms","start":"2026-08-14T09:39:19.576437Z","end":"2026-08-14T09:39:19.748807Z","steps":["trace[1161081839] 'process raft request'  (duration: 133.435954ms)","trace[1161081839] 'compare'  (duration: 38.199663ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:39:19.781032Z","caller":"traceutil/trace.go:171","msg":"trace[1693568118] transaction","detail":"{read_only:false; response_revision:8732; number_of_response:1; }","duration":"120.637031ms","start":"2026-08-14T09:39:19.660341Z","end":"2026-08-14T09:39:19.780978Z","steps":["trace[1693568118] 'process raft request'  (duration: 120.470987ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:39:22.206446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.160895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-14T09:39:22.206563Z","caller":"traceutil/trace.go:171","msg":"trace[107670421] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:8742; }","duration":"155.339699ms","start":"2026-08-14T09:39:22.051195Z","end":"2026-08-14T09:39:22.206535Z","steps":["trace[107670421] 'count revisions from in-memory index tree'  (duration: 155.067894ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:39:32.223226Z","caller":"traceutil/trace.go:171","msg":"trace[1079867137] transaction","detail":"{read_only:false; response_revision:8837; number_of_response:1; }","duration":"115.540716ms","start":"2026-08-14T09:39:32.107652Z","end":"2026-08-14T09:39:32.223192Z","steps":["trace[1079867137] 'process raft request'  (duration: 55.787215ms)","trace[1079867137] 'compare'  (duration: 59.609647ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:39:33.878342Z","caller":"traceutil/trace.go:171","msg":"trace[875388570] transaction","detail":"{read_only:false; response_revision:8851; number_of_response:1; }","duration":"144.068503ms","start":"2026-08-14T09:39:33.734244Z","end":"2026-08-14T09:39:33.878312Z","steps":["trace[875388570] 'process raft request'  (duration: 143.884929ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:40:51.332369Z","caller":"traceutil/trace.go:171","msg":"trace[1447922067] transaction","detail":"{read_only:false; response_revision:9604; number_of_response:1; }","duration":"269.04377ms","start":"2026-08-14T09:40:51.063292Z","end":"2026-08-14T09:40:51.332335Z","steps":["trace[1447922067] 'process raft request'  (duration: 268.699281ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:40:51.382538Z","caller":"traceutil/trace.go:171","msg":"trace[1664231491] linearizableReadLoop","detail":"{readStateIndex:9943; appliedIndex:9941; }","duration":"127.091139ms","start":"2026-08-14T09:40:51.255417Z","end":"2026-08-14T09:40:51.382509Z","steps":["trace[1664231491] 'read index received'  (duration: 76.665766ms)","trace[1664231491] 'applied index is now lower than readState.Index'  (duration: 50.424243ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T09:40:51.382668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.238233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-14T09:40:51.382703Z","caller":"traceutil/trace.go:171","msg":"trace[2057911329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9605; }","duration":"127.333115ms","start":"2026-08-14T09:40:51.255356Z","end":"2026-08-14T09:40:51.38269Z","steps":["trace[2057911329] 'agreement among raft nodes before linearized reading'  (duration: 127.253773ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:40:51.382715Z","caller":"traceutil/trace.go:171","msg":"trace[1192411599] transaction","detail":"{read_only:false; response_revision:9605; number_of_response:1; }","duration":"189.243049ms","start":"2026-08-14T09:40:51.193432Z","end":"2026-08-14T09:40:51.382676Z","steps":["trace[1192411599] 'process raft request'  (duration: 188.650625ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:40:51.540989Z","caller":"traceutil/trace.go:171","msg":"trace[2127759689] transaction","detail":"{read_only:false; response_revision:9607; number_of_response:1; }","duration":"120.145909ms","start":"2026-08-14T09:40:51.420802Z","end":"2026-08-14T09:40:51.540948Z","steps":["trace[2127759689] 'process raft request'  (duration: 119.941744ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:40:57.534066Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-14T09:40:57.539789Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-14T09:40:57.539875Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-14T09:43:01.898239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8087}
{"level":"info","ts":"2026-08-14T09:43:01.965987Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8087,"took":"63.605643ms","hash":3704893804,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":28721152,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-14T09:43:01.966066Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3704893804,"revision":8087,"compact-revision":6001}
{"level":"info","ts":"2026-08-14T09:46:31.741257Z","caller":"traceutil/trace.go:171","msg":"trace[252334656] linearizableReadLoop","detail":"{readStateIndex:12463; appliedIndex:12462; }","duration":"133.388066ms","start":"2026-08-14T09:46:31.607841Z","end":"2026-08-14T09:46:31.741229Z","steps":["trace[252334656] 'read index received'  (duration: 133.255493ms)","trace[252334656] 'applied index is now lower than readState.Index'  (duration: 131.433µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T09:46:31.741348Z","caller":"traceutil/trace.go:171","msg":"trace[1034394185] transaction","detail":"{read_only:false; response_revision:12046; number_of_response:1; }","duration":"139.546766ms","start":"2026-08-14T09:46:31.601773Z","end":"2026-08-14T09:46:31.74132Z","steps":["trace[1034394185] 'process raft request'  (duration: 139.270419ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T09:46:31.741514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.662233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-14T09:46:31.741562Z","caller":"traceutil/trace.go:171","msg":"trace[195444385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12046; }","duration":"133.726104ms","start":"2026-08-14T09:46:31.607821Z","end":"2026-08-14T09:46:31.741547Z","steps":["trace[195444385] 'agreement among raft nodes before linearized reading'  (duration: 133.561651ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:48:01.905666Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10499}
{"level":"info","ts":"2026-08-14T09:48:01.989256Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10499,"took":"81.310725ms","hash":51475725,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":26509312,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-14T09:48:01.989334Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":51475725,"revision":10499,"compact-revision":8087}
{"level":"info","ts":"2026-08-14T09:52:20.505287Z","caller":"traceutil/trace.go:171","msg":"trace[1242778862] transaction","detail":"{read_only:false; response_revision:14428; number_of_response:1; }","duration":"112.652105ms","start":"2026-08-14T09:52:20.392608Z","end":"2026-08-14T09:52:20.50526Z","steps":["trace[1242778862] 'process raft request'  (duration: 112.493532ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:52:38.683691Z","caller":"traceutil/trace.go:171","msg":"trace[788474427] transaction","detail":"{read_only:false; response_revision:14527; number_of_response:1; }","duration":"102.137179ms","start":"2026-08-14T09:52:38.581516Z","end":"2026-08-14T09:52:38.683653Z","steps":["trace[788474427] 'process raft request'  (duration: 101.939284ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:53:01.911453Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12657}
{"level":"info","ts":"2026-08-14T09:53:01.985344Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12657,"took":"71.511614ms","hash":2525816026,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":27340800,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-14T09:53:01.985394Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2525816026,"revision":12657,"compact-revision":10499}
{"level":"info","ts":"2026-08-14T09:53:16.072536Z","caller":"traceutil/trace.go:171","msg":"trace[54335245] transaction","detail":"{read_only:false; response_revision:14934; number_of_response:1; }","duration":"205.615501ms","start":"2026-08-14T09:53:15.866893Z","end":"2026-08-14T09:53:16.072508Z","steps":["trace[54335245] 'process raft request'  (duration: 205.334175ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:54:31.325321Z","caller":"traceutil/trace.go:171","msg":"trace[275589079] transaction","detail":"{read_only:false; response_revision:15685; number_of_response:1; }","duration":"120.612339ms","start":"2026-08-14T09:54:31.204688Z","end":"2026-08-14T09:54:31.325301Z","steps":["trace[275589079] 'process raft request'  (duration: 120.288911ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T09:58:01.917298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14679}
{"level":"info","ts":"2026-08-14T09:58:01.992726Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14679,"took":"72.750944ms","hash":4165927874,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":34349056,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-14T09:58:01.992789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4165927874,"revision":14679,"compact-revision":12657}
{"level":"info","ts":"2026-08-14T10:00:21.99405Z","caller":"traceutil/trace.go:171","msg":"trace[1489972538] transaction","detail":"{read_only:false; response_revision:18317; number_of_response:1; }","duration":"189.759773ms","start":"2026-08-14T10:00:21.804262Z","end":"2026-08-14T10:00:21.994022Z","steps":["trace[1489972538] 'process raft request'  (duration: 189.616169ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:00:21.994232Z","caller":"traceutil/trace.go:171","msg":"trace[824437691] transaction","detail":"{read_only:false; response_revision:18318; number_of_response:1; }","duration":"186.81816ms","start":"2026-08-14T10:00:21.807395Z","end":"2026-08-14T10:00:21.994213Z","steps":["trace[824437691] 'process raft request'  (duration: 186.587285ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:00:23.733794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.585692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-kqd7d\" ","response":"range_response_count:1 size:22022"}
{"level":"info","ts":"2026-08-14T10:00:23.73388Z","caller":"traceutil/trace.go:171","msg":"trace[298071982] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-kqd7d; range_end:; response_count:1; response_revision:18329; }","duration":"167.726566ms","start":"2026-08-14T10:00:23.566131Z","end":"2026-08-14T10:00:23.733857Z","steps":["trace[298071982] 'range keys from in-memory index tree'  (duration: 167.413148ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:02:01.431426Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-14T10:02:01.440787Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-14T10:02:01.440883Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-14T10:03:01.924695Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17335}
{"level":"info","ts":"2026-08-14T10:03:02.035446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17335,"took":"106.857193ms","hash":3099000534,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":35147776,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-14T10:03:02.035515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3099000534,"revision":17335,"compact-revision":14679}
{"level":"warn","ts":"2026-08-14T10:06:07.299749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.087932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18453"}
{"level":"info","ts":"2026-08-14T10:06:07.299855Z","caller":"traceutil/trace.go:171","msg":"trace[1701941489] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21063; }","duration":"124.232917ms","start":"2026-08-14T10:06:07.175602Z","end":"2026-08-14T10:06:07.299835Z","steps":["trace[1701941489] 'range keys from in-memory index tree'  (duration: 123.930759ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:06:07.439977Z","caller":"traceutil/trace.go:171","msg":"trace[1335953135] linearizableReadLoop","detail":"{readStateIndex:21781; appliedIndex:21780; }","duration":"129.222369ms","start":"2026-08-14T10:06:07.310724Z","end":"2026-08-14T10:06:07.439947Z","steps":["trace[1335953135] 'read index received'  (duration: 113.797793ms)","trace[1335953135] 'applied index is now lower than readState.Index'  (duration: 15.423616ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:06:07.44013Z","caller":"traceutil/trace.go:171","msg":"trace[1503499343] transaction","detail":"{read_only:false; response_revision:21065; number_of_response:1; }","duration":"139.855986ms","start":"2026-08-14T10:06:07.300231Z","end":"2026-08-14T10:06:07.440087Z","steps":["trace[1503499343] 'process raft request'  (duration: 124.345318ms)","trace[1503499343] 'compare'  (duration: 15.257212ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:06:07.448933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.135286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-08-14T10:06:07.449233Z","caller":"traceutil/trace.go:171","msg":"trace[2096184148] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:21065; }","duration":"138.423142ms","start":"2026-08-14T10:06:07.310701Z","end":"2026-08-14T10:06:07.449124Z","steps":["trace[2096184148] 'agreement among raft nodes before linearized reading'  (duration: 129.400583ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:06:07.45136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.024092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-14T10:06:07.451455Z","caller":"traceutil/trace.go:171","msg":"trace[305344069] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:21065; }","duration":"108.166235ms","start":"2026-08-14T10:06:07.343261Z","end":"2026-08-14T10:06:07.451428Z","steps":["trace[305344069] 'agreement among raft nodes before linearized reading'  (duration: 96.952961ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:06:23.336239Z","caller":"traceutil/trace.go:171","msg":"trace[1288191350] transaction","detail":"{read_only:false; response_revision:21145; number_of_response:1; }","duration":"136.407023ms","start":"2026-08-14T10:06:23.199799Z","end":"2026-08-14T10:06:23.336206Z","steps":["trace[1288191350] 'process raft request'  (duration: 135.980583ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:06:23.547204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.030033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564492554 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21137 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:06:23.547323Z","caller":"traceutil/trace.go:171","msg":"trace[825410251] transaction","detail":"{read_only:false; response_revision:21146; number_of_response:1; }","duration":"192.015967ms","start":"2026-08-14T10:06:23.355289Z","end":"2026-08-14T10:06:23.547305Z","steps":["trace[825410251] 'process raft request'  (duration: 39.785119ms)","trace[825410251] 'compare'  (duration: 151.90662ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:06:23.757858Z","caller":"traceutil/trace.go:171","msg":"trace[1842216177] linearizableReadLoop","detail":"{readStateIndex:21867; appliedIndex:21866; }","duration":"110.818588ms","start":"2026-08-14T10:06:23.647Z","end":"2026-08-14T10:06:23.757819Z","steps":["trace[1842216177] 'read index received'  (duration: 73.52767ms)","trace[1842216177] 'applied index is now lower than readState.Index'  (duration: 37.289438ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:06:23.757923Z","caller":"traceutil/trace.go:171","msg":"trace[745057844] transaction","detail":"{read_only:false; response_revision:21148; number_of_response:1; }","duration":"249.262542ms","start":"2026-08-14T10:06:23.508613Z","end":"2026-08-14T10:06:23.757876Z","steps":["trace[745057844] 'process raft request'  (duration: 211.822169ms)","trace[745057844] 'compare'  (duration: 37.245477ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:06:23.7581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.056296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:06:23.758167Z","caller":"traceutil/trace.go:171","msg":"trace[725961568] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:21148; }","duration":"111.195859ms","start":"2026-08-14T10:06:23.646953Z","end":"2026-08-14T10:06:23.758149Z","steps":["trace[725961568] 'agreement among raft nodes before linearized reading'  (duration: 111.049326ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:06:24.096414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.539573ms","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-08-14T10:06:24.096515Z","caller":"traceutil/trace.go:171","msg":"trace[1455203921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21149; }","duration":"163.701487ms","start":"2026-08-14T10:06:23.932786Z","end":"2026-08-14T10:06:24.096488Z","steps":["trace[1455203921] 'range keys from in-memory index tree'  (duration: 163.307588ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:06:24.249774Z","caller":"traceutil/trace.go:171","msg":"trace[597233445] transaction","detail":"{read_only:false; response_revision:21150; number_of_response:1; }","duration":"149.063211ms","start":"2026-08-14T10:06:24.100666Z","end":"2026-08-14T10:06:24.249729Z","steps":["trace[597233445] 'process raft request'  (duration: 148.864116ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:06:24.451132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.336032ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564492563 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21141 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:06:24.451438Z","caller":"traceutil/trace.go:171","msg":"trace[549610000] transaction","detail":"{read_only:false; response_revision:21151; number_of_response:1; }","duration":"350.652002ms","start":"2026-08-14T10:06:24.100758Z","end":"2026-08-14T10:06:24.45141Z","steps":["trace[549610000] 'process raft request'  (duration: 213.951971ms)","trace[549610000] 'compare'  (duration: 136.221579ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:06:24.451532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:06:24.100733Z","time spent":"350.753003ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21141 > 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-08-14T10:08:01.933333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19752}
{"level":"info","ts":"2026-08-14T10:08:02.04415Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19752,"took":"107.810719ms","hash":2492457707,"current-db-size-bytes":56508416,"current-db-size":"56 MB","current-db-size-in-use-bytes":29962240,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-14T10:08:02.044232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2492457707,"revision":19752,"compact-revision":17335}
{"level":"info","ts":"2026-08-14T10:10:03.316878Z","caller":"traceutil/trace.go:171","msg":"trace[522016706] linearizableReadLoop","detail":"{readStateIndex:23952; appliedIndex:23951; }","duration":"149.747702ms","start":"2026-08-14T10:10:03.167105Z","end":"2026-08-14T10:10:03.316853Z","steps":["trace[522016706] 'read index received'  (duration: 149.614089ms)","trace[522016706] 'applied index is now lower than readState.Index'  (duration: 132.763µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:10:03.31701Z","caller":"traceutil/trace.go:171","msg":"trace[686486474] transaction","detail":"{read_only:false; response_revision:23169; number_of_response:1; }","duration":"150.502791ms","start":"2026-08-14T10:10:03.166494Z","end":"2026-08-14T10:10:03.316997Z","steps":["trace[686486474] 'process raft request'  (duration: 150.142802ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:10:03.317173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.056491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/kubeadmconfigtemplates.bootstrap.cluster.x-k8s.io\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:10:03.317249Z","caller":"traceutil/trace.go:171","msg":"trace[1984047891] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/kubeadmconfigtemplates.bootstrap.cluster.x-k8s.io; range_end:; response_count:0; response_revision:23169; }","duration":"150.173043ms","start":"2026-08-14T10:10:03.167058Z","end":"2026-08-14T10:10:03.317231Z","steps":["trace[1984047891] 'agreement among raft nodes before linearized reading'  (duration: 150.05937ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:10:03.330352Z","caller":"traceutil/trace.go:171","msg":"trace[1680740288] transaction","detail":"{read_only:false; response_revision:23170; number_of_response:1; }","duration":"152.51189ms","start":"2026-08-14T10:10:03.177815Z","end":"2026-08-14T10:10:03.330326Z","steps":["trace[1680740288] 'process raft request'  (duration: 152.08616ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:10:08.285873Z","caller":"traceutil/trace.go:171","msg":"trace[1029778959] linearizableReadLoop","detail":"{readStateIndex:24281; appliedIndex:24280; }","duration":"100.791198ms","start":"2026-08-14T10:10:08.185046Z","end":"2026-08-14T10:10:08.285838Z","steps":["trace[1029778959] 'read index received'  (duration: 100.493271ms)","trace[1029778959] 'applied index is now lower than readState.Index'  (duration: 296.897µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:10:08.286203Z","caller":"traceutil/trace.go:171","msg":"trace[2098013369] transaction","detail":"{read_only:false; response_revision:23493; number_of_response:1; }","duration":"118.797197ms","start":"2026-08-14T10:10:08.167392Z","end":"2026-08-14T10:10:08.286189Z","steps":["trace[2098013369] 'process raft request'  (duration: 118.246774ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:10:08.286446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.375782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" limit:10000 ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-14T10:10:08.286449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.035214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:10:08.286494Z","caller":"traceutil/trace.go:171","msg":"trace[1894767168] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:23493; }","duration":"101.493765ms","start":"2026-08-14T10:10:08.184987Z","end":"2026-08-14T10:10:08.286481Z","steps":["trace[1894767168] 'agreement among raft nodes before linearized reading'  (duration: 101.396543ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:10:08.286507Z","caller":"traceutil/trace.go:171","msg":"trace[1094034459] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:23493; }","duration":"101.110356ms","start":"2026-08-14T10:10:08.185381Z","end":"2026-08-14T10:10:08.286492Z","steps":["trace[1094034459] 'agreement among raft nodes before linearized reading'  (duration: 101.000313ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:10:08.286611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.804528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/cert-manager-test/\" range_end:\"/registry/openstack.k-orc.cloud/groups/cert-manager-test0\" limit:10000 ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:10:08.28783Z","caller":"traceutil/trace.go:171","msg":"trace[1804007761] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/cert-manager-test/; range_end:/registry/openstack.k-orc.cloud/groups/cert-manager-test0; response_count:0; response_revision:23493; }","duration":"102.12454ms","start":"2026-08-14T10:10:08.185683Z","end":"2026-08-14T10:10:08.287808Z","steps":["trace[1804007761] 'agreement among raft nodes before linearized reading'  (duration: 100.794478ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:11:51.426397Z","caller":"traceutil/trace.go:171","msg":"trace[1585929463] transaction","detail":"{read_only:false; response_revision:24599; number_of_response:1; }","duration":"133.455744ms","start":"2026-08-14T10:11:51.292912Z","end":"2026-08-14T10:11:51.426368Z","steps":["trace[1585929463] 'process raft request'  (duration: 132.639675ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:01.940336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21998}
{"level":"info","ts":"2026-08-14T10:13:02.048804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21998,"took":"105.040822ms","hash":2886863073,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":44883968,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-08-14T10:13:02.048889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2886863073,"revision":21998,"compact-revision":19752}
{"level":"info","ts":"2026-08-14T10:13:51.172875Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067da.wal"}
{"level":"info","ts":"2026-08-14T10:13:56.084286Z","caller":"traceutil/trace.go:171","msg":"trace[252557790] transaction","detail":"{read_only:false; response_revision:25785; number_of_response:1; }","duration":"114.292487ms","start":"2026-08-14T10:13:55.969964Z","end":"2026-08-14T10:13:56.084257Z","steps":["trace[252557790] 'process raft request'  (duration: 113.609511ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:56.28147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.191682ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564504711 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/container-infra.18cba46275fc2a5c\" mod_revision:25565 > success:<request_put:<key:\"/registry/events/openstack/container-infra.18cba46275fc2a5c\" value_size:600 lease:2834347460564503932 >> failure:<request_range:<key:\"/registry/events/openstack/container-infra.18cba46275fc2a5c\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:13:56.281596Z","caller":"traceutil/trace.go:171","msg":"trace[2102960956] transaction","detail":"{read_only:false; response_revision:25786; number_of_response:1; }","duration":"194.826102ms","start":"2026-08-14T10:13:56.086745Z","end":"2026-08-14T10:13:56.281571Z","steps":["trace[2102960956] 'process raft request'  (duration: 67.445535ms)","trace[2102960956] 'compare'  (duration: 126.941985ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:13:57.017159Z","caller":"traceutil/trace.go:171","msg":"trace[789017765] linearizableReadLoop","detail":"{readStateIndex:26635; appliedIndex:26634; }","duration":"287.206414ms","start":"2026-08-14T10:13:56.729921Z","end":"2026-08-14T10:13:57.017127Z","steps":["trace[789017765] 'read index received'  (duration: 287.073901ms)","trace[789017765] 'applied index is now lower than readState.Index'  (duration: 131.503µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:13:57.017302Z","caller":"traceutil/trace.go:171","msg":"trace[631134354] transaction","detail":"{read_only:false; response_revision:25790; number_of_response:1; }","duration":"411.882655ms","start":"2026-08-14T10:13:56.605368Z","end":"2026-08-14T10:13:57.01725Z","steps":["trace[631134354] 'process raft request'  (duration: 411.425774ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:57.017388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.44006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-14T10:13:57.017461Z","caller":"traceutil/trace.go:171","msg":"trace[634395047] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25790; }","duration":"287.586323ms","start":"2026-08-14T10:13:56.72986Z","end":"2026-08-14T10:13:57.017446Z","steps":["trace[634395047] 'agreement among raft nodes before linearized reading'  (duration: 287.388458ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:57.017502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:56.60533Z","time spent":"412.06133ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25764 > 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-08-14T10:13:57.033436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.120663ms","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-08-14T10:13:57.03356Z","caller":"traceutil/trace.go:171","msg":"trace[759514357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25791; }","duration":"194.261057ms","start":"2026-08-14T10:13:56.839264Z","end":"2026-08-14T10:13:57.033525Z","steps":["trace[759514357] 'agreement among raft nodes before linearized reading'  (duration: 194.063842ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:57.033939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.024872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-14T10:13:57.034034Z","caller":"traceutil/trace.go:171","msg":"trace[835424395] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:25791; }","duration":"260.148605ms","start":"2026-08-14T10:13:56.773867Z","end":"2026-08-14T10:13:57.034015Z","steps":["trace[835424395] 'agreement among raft nodes before linearized reading'  (duration: 259.975521ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:57.190118Z","caller":"traceutil/trace.go:171","msg":"trace[701797876] linearizableReadLoop","detail":"{readStateIndex:26637; appliedIndex:26636; }","duration":"111.077169ms","start":"2026-08-14T10:13:57.079015Z","end":"2026-08-14T10:13:57.190092Z","steps":["trace[701797876] 'read index received'  (duration: 66.02417ms)","trace[701797876] 'applied index is now lower than readState.Index'  (duration: 45.050719ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:13:57.190139Z","caller":"traceutil/trace.go:171","msg":"trace[869489499] transaction","detail":"{read_only:false; response_revision:25793; number_of_response:1; }","duration":"102.285295ms","start":"2026-08-14T10:13:57.087828Z","end":"2026-08-14T10:13:57.190113Z","steps":["trace[869489499] 'process raft request'  (duration: 101.892166ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:57.190306Z","caller":"traceutil/trace.go:171","msg":"trace[1578602985] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"153.523774ms","start":"2026-08-14T10:13:57.036657Z","end":"2026-08-14T10:13:57.190181Z","steps":["trace[1578602985] 'process raft request'  (duration: 108.408104ms)","trace[1578602985] 'compare'  (duration: 44.361592ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:13:57.190439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.370517ms","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-08-14T10:13:57.190485Z","caller":"traceutil/trace.go:171","msg":"trace[711704249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25794; }","duration":"111.499369ms","start":"2026-08-14T10:13:57.078974Z","end":"2026-08-14T10:13:57.190474Z","steps":["trace[711704249] 'agreement among raft nodes before linearized reading'  (duration: 111.238813ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:57.22457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.964175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-14T10:13:57.224661Z","caller":"traceutil/trace.go:171","msg":"trace[345761761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25795; }","duration":"145.079817ms","start":"2026-08-14T10:13:57.079565Z","end":"2026-08-14T10:13:57.224645Z","steps":["trace[345761761] 'agreement among raft nodes before linearized reading'  (duration: 144.859462ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:57.394705Z","caller":"traceutil/trace.go:171","msg":"trace[335799242] linearizableReadLoop","detail":"{readStateIndex:26643; appliedIndex:26642; }","duration":"117.368612ms","start":"2026-08-14T10:13:57.277312Z","end":"2026-08-14T10:13:57.39468Z","steps":["trace[335799242] 'read index received'  (duration: 115.762683ms)","trace[335799242] 'applied index is now lower than readState.Index'  (duration: 1.604159ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:13:57.394721Z","caller":"traceutil/trace.go:171","msg":"trace[1542477259] transaction","detail":"{read_only:false; response_revision:25798; number_of_response:1; }","duration":"165.672031ms","start":"2026-08-14T10:13:57.22903Z","end":"2026-08-14T10:13:57.394702Z","steps":["trace[1542477259] 'process raft request'  (duration: 163.922858ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:57.39485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.523896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-14T10:13:57.394882Z","caller":"traceutil/trace.go:171","msg":"trace[232815381] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25800; }","duration":"117.607798ms","start":"2026-08-14T10:13:57.277269Z","end":"2026-08-14T10:13:57.394877Z","steps":["trace[232815381] 'agreement among raft nodes before linearized reading'  (duration: 117.534196ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:58.08393Z","caller":"traceutil/trace.go:171","msg":"trace[178110735] linearizableReadLoop","detail":"{readStateIndex:26646; appliedIndex:26645; }","duration":"104.407136ms","start":"2026-08-14T10:13:57.979491Z","end":"2026-08-14T10:13:58.083898Z","steps":["trace[178110735] 'read index received'  (duration: 104.207801ms)","trace[178110735] 'applied index is now lower than readState.Index'  (duration: 197.985µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:13:58.084083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.564619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:13:58.084117Z","caller":"traceutil/trace.go:171","msg":"trace[801147011] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25801; }","duration":"104.662062ms","start":"2026-08-14T10:13:57.979445Z","end":"2026-08-14T10:13:58.084107Z","steps":["trace[801147011] 'agreement among raft nodes before linearized reading'  (duration: 104.566449ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:58.084052Z","caller":"traceutil/trace.go:171","msg":"trace[1487573365] transaction","detail":"{read_only:false; response_revision:25801; number_of_response:1; }","duration":"208.761271ms","start":"2026-08-14T10:13:57.875236Z","end":"2026-08-14T10:13:58.083997Z","steps":["trace[1487573365] 'process raft request'  (duration: 208.468274ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:58.429863Z","caller":"traceutil/trace.go:171","msg":"trace[952658134] transaction","detail":"{read_only:false; response_revision:25802; number_of_response:1; }","duration":"132.671996ms","start":"2026-08-14T10:13:58.297166Z","end":"2026-08-14T10:13:58.429838Z","steps":["trace[952658134] 'process raft request'  (duration: 132.509291ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:58.723289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.422677ms","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-08-14T10:13:58.723384Z","caller":"traceutil/trace.go:171","msg":"trace[346443988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25802; }","duration":"152.573861ms","start":"2026-08-14T10:13:58.570788Z","end":"2026-08-14T10:13:58.723362Z","steps":["trace[346443988] 'range keys from in-memory index tree'  (duration: 152.232042ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:58.838142Z","caller":"traceutil/trace.go:171","msg":"trace[789394157] transaction","detail":"{read_only:false; response_revision:25803; number_of_response:1; }","duration":"109.947731ms","start":"2026-08-14T10:13:58.728166Z","end":"2026-08-14T10:13:58.838114Z","steps":["trace[789394157] 'process raft request'  (duration: 109.777277ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.099032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.479649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"info","ts":"2026-08-14T10:13:59.099112Z","caller":"traceutil/trace.go:171","msg":"trace[1987247629] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25803; }","duration":"127.603532ms","start":"2026-08-14T10:13:58.971489Z","end":"2026-08-14T10:13:59.099093Z","steps":["trace[1987247629] 'range keys from in-memory index tree'  (duration: 127.302094ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.192862Z","caller":"traceutil/trace.go:171","msg":"trace[1245829061] transaction","detail":"{read_only:false; response_revision:25804; number_of_response:1; }","duration":"154.781624ms","start":"2026-08-14T10:13:59.038044Z","end":"2026-08-14T10:13:59.192826Z","steps":["trace[1245829061] 'process raft request'  (duration: 154.19991ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.278684Z","caller":"traceutil/trace.go:171","msg":"trace[1034268197] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"175.992362ms","start":"2026-08-14T10:13:59.10267Z","end":"2026-08-14T10:13:59.278663Z","steps":["trace[1034268197] 'process raft request'  (duration: 171.691887ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.334384Z","caller":"traceutil/trace.go:171","msg":"trace[1210006434] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"138.314843ms","start":"2026-08-14T10:13:59.196035Z","end":"2026-08-14T10:13:59.33435Z","steps":["trace[1210006434] 'process raft request'  (duration: 138.209331ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.334554Z","caller":"traceutil/trace.go:171","msg":"trace[1899589595] transaction","detail":"{read_only:false; response_revision:25808; number_of_response:1; }","duration":"104.259193ms","start":"2026-08-14T10:13:59.230267Z","end":"2026-08-14T10:13:59.334526Z","steps":["trace[1899589595] 'process raft request'  (duration: 104.030027ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.334691Z","caller":"traceutil/trace.go:171","msg":"trace[1507815603] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"138.727704ms","start":"2026-08-14T10:13:59.195929Z","end":"2026-08-14T10:13:59.334657Z","steps":["trace[1507815603] 'process raft request'  (duration: 138.096188ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.364233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.339997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:176"}
{"level":"info","ts":"2026-08-14T10:13:59.364274Z","caller":"traceutil/trace.go:171","msg":"trace[852288598] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:25810; }","duration":"100.430709ms","start":"2026-08-14T10:13:59.263834Z","end":"2026-08-14T10:13:59.364265Z","steps":["trace[852288598] 'agreement among raft nodes before linearized reading'  (duration: 100.324767ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.670106Z","caller":"traceutil/trace.go:171","msg":"trace[1374388523] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"301.246976ms","start":"2026-08-14T10:13:59.368835Z","end":"2026-08-14T10:13:59.670082Z","steps":["trace[1374388523] 'process raft request'  (duration: 301.112383ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.670246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:59.368778Z","time spent":"301.39748ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25745 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-14T10:13:59.788964Z","caller":"traceutil/trace.go:171","msg":"trace[1115237974] linearizableReadLoop","detail":"{readStateIndex:26657; appliedIndex:26656; }","duration":"418.604469ms","start":"2026-08-14T10:13:59.370326Z","end":"2026-08-14T10:13:59.788931Z","steps":["trace[1115237974] 'read index received'  (duration: 299.73206ms)","trace[1115237974] 'applied index is now lower than readState.Index'  (duration: 118.871409ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:13:59.78899Z","caller":"traceutil/trace.go:171","msg":"trace[719726945] transaction","detail":"{read_only:false; response_revision:25812; number_of_response:1; }","duration":"419.568683ms","start":"2026-08-14T10:13:59.369369Z","end":"2026-08-14T10:13:59.788938Z","steps":["trace[719726945] 'process raft request'  (duration: 418.013164ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:13:59.789108Z","caller":"traceutil/trace.go:171","msg":"trace[311011803] transaction","detail":"{read_only:false; response_revision:25813; number_of_response:1; }","duration":"388.32646ms","start":"2026-08-14T10:13:59.400771Z","end":"2026-08-14T10:13:59.789098Z","steps":["trace[311011803] 'process raft request'  (duration: 388.053864ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.789317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.962759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:13:59.789388Z","caller":"traceutil/trace.go:171","msg":"trace[2024371726] transaction","detail":"{read_only:false; response_revision:25814; number_of_response:1; }","duration":"388.515506ms","start":"2026-08-14T10:13:59.400843Z","end":"2026-08-14T10:13:59.789358Z","steps":["trace[2024371726] 'process raft request'  (duration: 388.055665ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.789422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:59.400741Z","time spent":"388.393922ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25800 > 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-08-14T10:13:59.789203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:59.369341Z","time spent":"419.738707ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25796 > 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-08-14T10:13:59.789426Z","caller":"traceutil/trace.go:171","msg":"trace[925176051] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25814; }","duration":"419.123442ms","start":"2026-08-14T10:13:59.370276Z","end":"2026-08-14T10:13:59.789399Z","steps":["trace[925176051] 'agreement among raft nodes before linearized reading'  (duration: 418.920927ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.789526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:59.400815Z","time spent":"388.638878ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25799 > 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-08-14T10:13:59.789591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:59.370255Z","time spent":"419.274106ms","remote":"127.0.0.1:49112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-08-14T10:13:59.789607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.659488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-14T10:13:59.789681Z","caller":"traceutil/trace.go:171","msg":"trace[157351089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25814; }","duration":"390.814052ms","start":"2026-08-14T10:13:59.398849Z","end":"2026-08-14T10:13:59.789663Z","steps":["trace[157351089] 'agreement among raft nodes before linearized reading'  (duration: 390.379402ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:13:59.789717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:13:59.398837Z","time spent":"390.873033ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-14T10:14:01.121056Z","caller":"traceutil/trace.go:171","msg":"trace[1536387909] transaction","detail":"{read_only:false; response_revision:25817; number_of_response:1; }","duration":"274.982596ms","start":"2026-08-14T10:14:00.846042Z","end":"2026-08-14T10:14:01.121025Z","steps":["trace[1536387909] 'process raft request'  (duration: 274.72898ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:01.303195Z","caller":"traceutil/trace.go:171","msg":"trace[1002064207] transaction","detail":"{read_only:false; response_revision:25818; number_of_response:1; }","duration":"103.268159ms","start":"2026-08-14T10:14:01.199891Z","end":"2026-08-14T10:14:01.303159Z","steps":["trace[1002064207] 'process raft request'  (duration: 101.215128ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:01.472666Z","caller":"traceutil/trace.go:171","msg":"trace[474909585] transaction","detail":"{read_only:false; response_revision:25820; number_of_response:1; }","duration":"132.957323ms","start":"2026-08-14T10:14:01.339672Z","end":"2026-08-14T10:14:01.47263Z","steps":["trace[474909585] 'process raft request'  (duration: 131.050646ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:01.496107Z","caller":"traceutil/trace.go:171","msg":"trace[468097967] transaction","detail":"{read_only:false; response_revision:25821; number_of_response:1; }","duration":"155.039021ms","start":"2026-08-14T10:14:01.341037Z","end":"2026-08-14T10:14:01.496076Z","steps":["trace[468097967] 'process raft request'  (duration: 154.768734ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:01.4964Z","caller":"traceutil/trace.go:171","msg":"trace[1734970247] linearizableReadLoop","detail":"{readStateIndex:26668; appliedIndex:26665; }","duration":"127.748274ms","start":"2026-08-14T10:14:01.368638Z","end":"2026-08-14T10:14:01.496386Z","steps":["trace[1734970247] 'read index received'  (duration: 102.109209ms)","trace[1734970247] 'applied index is now lower than readState.Index'  (duration: 25.637835ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:01.496456Z","caller":"traceutil/trace.go:171","msg":"trace[616295153] transaction","detail":"{read_only:false; response_revision:25822; number_of_response:1; }","duration":"154.825886ms","start":"2026-08-14T10:14:01.34159Z","end":"2026-08-14T10:14:01.496416Z","steps":["trace[616295153] 'process raft request'  (duration: 154.430756ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:01.496496Z","caller":"traceutil/trace.go:171","msg":"trace[2026660002] transaction","detail":"{read_only:false; response_revision:25823; number_of_response:1; }","duration":"125.45177ms","start":"2026-08-14T10:14:01.371006Z","end":"2026-08-14T10:14:01.496458Z","steps":["trace[2026660002] 'process raft request'  (duration: 125.253035ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:01.496591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.942659ms","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-08-14T10:14:01.497271Z","caller":"traceutil/trace.go:171","msg":"trace[1221883703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25823; }","duration":"128.613335ms","start":"2026-08-14T10:14:01.368621Z","end":"2026-08-14T10:14:01.497234Z","steps":["trace[1221883703] 'agreement among raft nodes before linearized reading'  (duration: 127.802606ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:01.862694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.137386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:01.862765Z","caller":"traceutil/trace.go:171","msg":"trace[1445018041] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:25824; }","duration":"119.256358ms","start":"2026-08-14T10:14:01.743495Z","end":"2026-08-14T10:14:01.862752Z","steps":["trace[1445018041] 'count revisions from in-memory index tree'  (duration: 118.971902ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:02.183486Z","caller":"traceutil/trace.go:171","msg":"trace[1924755900] linearizableReadLoop","detail":"{readStateIndex:26674; appliedIndex:26673; }","duration":"204.941238ms","start":"2026-08-14T10:14:01.978522Z","end":"2026-08-14T10:14:02.183463Z","steps":["trace[1924755900] 'read index received'  (duration: 140.907458ms)","trace[1924755900] 'applied index is now lower than readState.Index'  (duration: 64.03304ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:02.183645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.727278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:02.183667Z","caller":"traceutil/trace.go:171","msg":"trace[1101851576] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:25828; }","duration":"203.77737ms","start":"2026-08-14T10:14:01.979884Z","end":"2026-08-14T10:14:02.183661Z","steps":["trace[1101851576] 'agreement among raft nodes before linearized reading'  (duration: 203.698937ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:02.183789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.245766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"}
{"level":"info","ts":"2026-08-14T10:14:02.183789Z","caller":"traceutil/trace.go:171","msg":"trace[1041900159] transaction","detail":"{read_only:false; response_revision:25828; number_of_response:1; }","duration":"315.364651ms","start":"2026-08-14T10:14:01.868387Z","end":"2026-08-14T10:14:02.183751Z","steps":["trace[1041900159] 'process raft request'  (duration: 251.044033ms)","trace[1041900159] 'compare'  (duration: 63.813835ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:02.183878Z","caller":"traceutil/trace.go:171","msg":"trace[57498191] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:25828; }","duration":"205.38032ms","start":"2026-08-14T10:14:01.978479Z","end":"2026-08-14T10:14:02.183859Z","steps":["trace[57498191] 'agreement among raft nodes before linearized reading'  (duration: 205.101852ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:02.18395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.067492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/pxc-operator\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-08-14T10:14:02.183972Z","caller":"traceutil/trace.go:171","msg":"trace[1323716044] range","detail":"{range_begin:/registry/serviceaccounts/openstack/pxc-operator; range_end:; response_count:1; response_revision:25828; }","duration":"155.134354ms","start":"2026-08-14T10:14:02.028833Z","end":"2026-08-14T10:14:02.183967Z","steps":["trace[1323716044] 'agreement among raft nodes before linearized reading'  (duration: 155.054603ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:02.183983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:01.868363Z","time spent":"315.509815ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25815 > 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-08-14T10:14:09.550043Z","caller":"traceutil/trace.go:171","msg":"trace[1068824381] linearizableReadLoop","detail":"{readStateIndex:26724; appliedIndex:26723; }","duration":"191.576142ms","start":"2026-08-14T10:14:09.358442Z","end":"2026-08-14T10:14:09.550018Z","steps":["trace[1068824381] 'read index received'  (duration: 191.421588ms)","trace[1068824381] 'applied index is now lower than readState.Index'  (duration: 153.104µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:09.550164Z","caller":"traceutil/trace.go:171","msg":"trace[985668904] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"221.323017ms","start":"2026-08-14T10:14:09.328813Z","end":"2026-08-14T10:14:09.550136Z","steps":["trace[985668904] 'process raft request'  (duration: 221.071571ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:09.550249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.806408ms","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-08-14T10:14:09.550276Z","caller":"traceutil/trace.go:171","msg":"trace[901147801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25877; }","duration":"191.884529ms","start":"2026-08-14T10:14:09.358384Z","end":"2026-08-14T10:14:09.550268Z","steps":["trace[901147801] 'agreement among raft nodes before linearized reading'  (duration: 191.735095ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:09.826742Z","caller":"traceutil/trace.go:171","msg":"trace[1389757274] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"277.736394ms","start":"2026-08-14T10:14:09.548973Z","end":"2026-08-14T10:14:09.82671Z","steps":["trace[1389757274] 'process raft request'  (duration: 277.668202ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:09.826869Z","caller":"traceutil/trace.go:171","msg":"trace[947638271] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"327.131478ms","start":"2026-08-14T10:14:09.499708Z","end":"2026-08-14T10:14:09.82684Z","steps":["trace[947638271] 'process raft request'  (duration: 322.812332ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:09.827011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.499677Z","time spent":"327.257091ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25864 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-14T10:14:10.174874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.337478ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564504932 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25865 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:10.175323Z","caller":"traceutil/trace.go:171","msg":"trace[1663575453] transaction","detail":"{read_only:false; response_revision:25883; number_of_response:1; }","duration":"282.041788ms","start":"2026-08-14T10:14:09.893257Z","end":"2026-08-14T10:14:10.175299Z","steps":["trace[1663575453] 'process raft request'  (duration: 281.975876ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:10.175321Z","caller":"traceutil/trace.go:171","msg":"trace[1994368169] transaction","detail":"{read_only:false; response_revision:25882; number_of_response:1; }","duration":"621.338543ms","start":"2026-08-14T10:14:09.553947Z","end":"2026-08-14T10:14:10.175285Z","steps":["trace[1994368169] 'process raft request'  (duration: 621.224931ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:10.175425Z","caller":"traceutil/trace.go:171","msg":"trace[2017905008] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"624.738896ms","start":"2026-08-14T10:14:09.550652Z","end":"2026-08-14T10:14:10.175391Z","steps":["trace[2017905008] 'process raft request'  (duration: 475.808834ms)","trace[2017905008] 'compare'  (duration: 147.305003ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:10.175473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.553932Z","time spent":"621.467206ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25863 > 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-08-14T10:14:10.17559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.550641Z","time spent":"624.867089ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25865 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-14T10:14:10.175605Z","caller":"traceutil/trace.go:171","msg":"trace[158887928] transaction","detail":"{read_only:false; response_revision:25881; number_of_response:1; }","duration":"623.469405ms","start":"2026-08-14T10:14:09.552129Z","end":"2026-08-14T10:14:10.175598Z","steps":["trace[158887928] 'process raft request'  (duration: 622.85858ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.175653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.552118Z","time spent":"623.512046ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25867 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-08-14T10:14:10.175713Z","caller":"traceutil/trace.go:171","msg":"trace[2089511038] linearizableReadLoop","detail":"{readStateIndex:26729; appliedIndex:26724; }","duration":"595.676666ms","start":"2026-08-14T10:14:09.580026Z","end":"2026-08-14T10:14:10.175703Z","steps":["trace[2089511038] 'read index received'  (duration: 242.580635ms)","trace[2089511038] 'applied index is now lower than readState.Index'  (duration: 353.094851ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:10.175967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.943773ms","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-08-14T10:14:10.175995Z","caller":"traceutil/trace.go:171","msg":"trace[1907719955] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25884; }","duration":"596.005045ms","start":"2026-08-14T10:14:09.579983Z","end":"2026-08-14T10:14:10.175988Z","steps":["trace[1907719955] 'agreement among raft nodes before linearized reading'  (duration: 595.902952ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.176038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.57997Z","time spent":"596.040397ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-14T10:14:10.176055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.581864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:10.176086Z","caller":"traceutil/trace.go:171","msg":"trace[1920013261] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25884; }","duration":"501.657995ms","start":"2026-08-14T10:14:09.674419Z","end":"2026-08-14T10:14:10.176077Z","steps":["trace[1920013261] 'agreement among raft nodes before linearized reading'  (duration: 501.607014ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.176113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.674397Z","time spent":"501.710736ms","remote":"127.0.0.1:47946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"warn","ts":"2026-08-14T10:14:10.176221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.089415ms","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-08-14T10:14:10.176268Z","caller":"traceutil/trace.go:171","msg":"trace[1160678125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25884; }","duration":"242.169937ms","start":"2026-08-14T10:14:09.934087Z","end":"2026-08-14T10:14:10.176257Z","steps":["trace[1160678125] 'agreement among raft nodes before linearized reading'  (duration: 241.995393ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:10.17574Z","caller":"traceutil/trace.go:171","msg":"trace[1225260223] transaction","detail":"{read_only:false; response_revision:25884; number_of_response:1; }","duration":"280.693275ms","start":"2026-08-14T10:14:09.89504Z","end":"2026-08-14T10:14:10.175733Z","steps":["trace[1225260223] 'process raft request'  (duration: 280.220834ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.176364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.281357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:10.176387Z","caller":"traceutil/trace.go:171","msg":"trace[706761701] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25884; }","duration":"303.338239ms","start":"2026-08-14T10:14:09.873041Z","end":"2026-08-14T10:14:10.17638Z","steps":["trace[706761701] 'agreement among raft nodes before linearized reading'  (duration: 303.306408ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.176408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:09.873025Z","time spent":"303.378879ms","remote":"127.0.0.1:38534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-08-14T10:14:10.176496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.474441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:10.176536Z","caller":"traceutil/trace.go:171","msg":"trace[1126107672] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25884; }","duration":"139.548303ms","start":"2026-08-14T10:14:10.036977Z","end":"2026-08-14T10:14:10.176525Z","steps":["trace[1126107672] 'agreement among raft nodes before linearized reading'  (duration: 139.485202ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.176332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.322637ms","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:8"}
{"level":"info","ts":"2026-08-14T10:14:10.176628Z","caller":"traceutil/trace.go:171","msg":"trace[54119806] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:25884; }","duration":"264.633924ms","start":"2026-08-14T10:14:09.911985Z","end":"2026-08-14T10:14:10.176619Z","steps":["trace[54119806] 'agreement among raft nodes before linearized reading'  (duration: 264.263086ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.796704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.454197ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564504944 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25873 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:10.796825Z","caller":"traceutil/trace.go:171","msg":"trace[675472758] linearizableReadLoop","detail":"{readStateIndex:26734; appliedIndex:26733; }","duration":"545.718599ms","start":"2026-08-14T10:14:10.251088Z","end":"2026-08-14T10:14:10.796806Z","steps":["trace[675472758] 'read index received'  (duration: 359.16089ms)","trace[675472758] 'applied index is now lower than readState.Index'  (duration: 186.556499ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:10.797086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.985796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:10.79713Z","caller":"traceutil/trace.go:171","msg":"trace[774290611] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25887; }","duration":"546.049317ms","start":"2026-08-14T10:14:10.251068Z","end":"2026-08-14T10:14:10.797117Z","steps":["trace[774290611] 'agreement among raft nodes before linearized reading'  (duration: 545.923564ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.797829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:10.251057Z","time spent":"546.717923ms","remote":"127.0.0.1:49208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "}
{"level":"info","ts":"2026-08-14T10:14:10.798354Z","caller":"traceutil/trace.go:171","msg":"trace[542062991] transaction","detail":"{read_only:false; response_revision:25887; number_of_response:1; }","duration":"549.779328ms","start":"2026-08-14T10:14:10.248564Z","end":"2026-08-14T10:14:10.798344Z","steps":["trace[542062991] 'process raft request'  (duration: 361.592588ms)","trace[542062991] 'compare'  (duration: 185.912815ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:10.798888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:10.248544Z","time spent":"549.84004ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25873 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-08-14T10:14:10.897871Z","caller":"traceutil/trace.go:171","msg":"trace[1062162101] transaction","detail":"{read_only:false; response_revision:25888; number_of_response:1; }","duration":"352.096657ms","start":"2026-08-14T10:14:10.54571Z","end":"2026-08-14T10:14:10.897807Z","steps":["trace[1062162101] 'process raft request'  (duration: 351.651547ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:10.898113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:10.545688Z","time spent":"352.293762ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25874 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-08-14T10:14:11.367998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.92126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:11.36808Z","caller":"traceutil/trace.go:171","msg":"trace[593709223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25889; }","duration":"112.058043ms","start":"2026-08-14T10:14:11.256003Z","end":"2026-08-14T10:14:11.368061Z","steps":["trace[593709223] 'range keys from in-memory index tree'  (duration: 111.664414ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:11.368161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.668105ms","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-08-14T10:14:11.368248Z","caller":"traceutil/trace.go:171","msg":"trace[251562505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25889; }","duration":"182.818138ms","start":"2026-08-14T10:14:11.185415Z","end":"2026-08-14T10:14:11.368233Z","steps":["trace[251562505] 'range keys from in-memory index tree'  (duration: 182.431109ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:11.6862Z","caller":"traceutil/trace.go:171","msg":"trace[1229541693] transaction","detail":"{read_only:false; response_revision:25891; number_of_response:1; }","duration":"129.740555ms","start":"2026-08-14T10:14:11.556418Z","end":"2026-08-14T10:14:11.686159Z","steps":["trace[1229541693] 'process raft request'  (duration: 126.617628ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.034061Z","caller":"traceutil/trace.go:171","msg":"trace[130476205] linearizableReadLoop","detail":"{readStateIndex:26828; appliedIndex:26827; }","duration":"223.286345ms","start":"2026-08-14T10:14:15.81076Z","end":"2026-08-14T10:14:16.034046Z","steps":["trace[130476205] 'read index received'  (duration: 223.243094ms)","trace[130476205] 'applied index is now lower than readState.Index'  (duration: 42.471µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:16.034266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.499911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:16.03429Z","caller":"traceutil/trace.go:171","msg":"trace[1483017350] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:25979; }","duration":"223.578443ms","start":"2026-08-14T10:14:15.810704Z","end":"2026-08-14T10:14:16.034283Z","steps":["trace[1483017350] 'agreement among raft nodes before linearized reading'  (duration: 223.523682ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.034236Z","caller":"traceutil/trace.go:171","msg":"trace[655657696] transaction","detail":"{read_only:false; response_revision:25979; number_of_response:1; }","duration":"336.129928ms","start":"2026-08-14T10:14:15.698069Z","end":"2026-08-14T10:14:16.034199Z","steps":["trace[655657696] 'process raft request'  (duration: 335.861712ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.034438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:15.698034Z","time spent":"336.301891ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25906 > 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-08-14T10:14:16.114956Z","caller":"traceutil/trace.go:171","msg":"trace[2024943963] transaction","detail":"{read_only:false; response_revision:25980; number_of_response:1; }","duration":"267.107235ms","start":"2026-08-14T10:14:15.847814Z","end":"2026-08-14T10:14:16.114921Z","steps":["trace[2024943963] 'process raft request'  (duration: 264.683956ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.115232Z","caller":"traceutil/trace.go:171","msg":"trace[64007981] transaction","detail":"{read_only:false; response_revision:25981; number_of_response:1; }","duration":"267.274579ms","start":"2026-08-14T10:14:15.847931Z","end":"2026-08-14T10:14:16.115206Z","steps":["trace[64007981] 'process raft request'  (duration: 266.860858ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.115205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.303303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:16.115761Z","caller":"traceutil/trace.go:171","msg":"trace[1143233496] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:25982; }","duration":"124.947448ms","start":"2026-08-14T10:14:15.990801Z","end":"2026-08-14T10:14:16.115748Z","steps":["trace[1143233496] 'agreement among raft nodes before linearized reading'  (duration: 124.337313ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.368008Z","caller":"traceutil/trace.go:171","msg":"trace[442084920] transaction","detail":"{read_only:false; response_revision:25983; number_of_response:1; }","duration":"243.629152ms","start":"2026-08-14T10:14:16.124346Z","end":"2026-08-14T10:14:16.367975Z","steps":["trace[442084920] 'process raft request'  (duration: 243.338115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.535998Z","caller":"traceutil/trace.go:171","msg":"trace[727083647] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"335.484342ms","start":"2026-08-14T10:14:16.20049Z","end":"2026-08-14T10:14:16.535975Z","steps":["trace[727083647] 'process raft request'  (duration: 335.424291ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.536035Z","caller":"traceutil/trace.go:171","msg":"trace[1752419973] transaction","detail":"{read_only:false; response_revision:25984; number_of_response:1; }","duration":"337.43964ms","start":"2026-08-14T10:14:16.198555Z","end":"2026-08-14T10:14:16.535994Z","steps":["trace[1752419973] 'process raft request'  (duration: 337.198734ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.536079Z","caller":"traceutil/trace.go:171","msg":"trace[857314390] transaction","detail":"{read_only:false; response_revision:25985; number_of_response:1; }","duration":"337.137023ms","start":"2026-08-14T10:14:16.198889Z","end":"2026-08-14T10:14:16.536026Z","steps":["trace[857314390] 'process raft request'  (duration: 337.001719ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.536163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:16.200463Z","time spent":"335.618125ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25911 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-14T10:14:16.53624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:16.198541Z","time spent":"337.581504ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25910 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-14T10:14:16.536286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:16.198878Z","time spent":"337.286527ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25909 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-14T10:14:16.536356Z","caller":"traceutil/trace.go:171","msg":"trace[379936181] linearizableReadLoop","detail":"{readStateIndex:26836; appliedIndex:26831; }","duration":"331.808732ms","start":"2026-08-14T10:14:16.204501Z","end":"2026-08-14T10:14:16.536309Z","steps":["trace[379936181] 'read index received'  (duration: 163.155549ms)","trace[379936181] 'applied index is now lower than readState.Index'  (duration: 168.650123ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:16.53638Z","caller":"traceutil/trace.go:171","msg":"trace[2122485002] transaction","detail":"{read_only:false; response_revision:25987; number_of_response:1; }","duration":"334.740264ms","start":"2026-08-14T10:14:16.2016Z","end":"2026-08-14T10:14:16.536341Z","steps":["trace[2122485002] 'process raft request'  (duration: 334.341235ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.536526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.021927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-14T10:14:16.536558Z","caller":"traceutil/trace.go:171","msg":"trace[262179175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25987; }","duration":"332.076339ms","start":"2026-08-14T10:14:16.204474Z","end":"2026-08-14T10:14:16.53655Z","steps":["trace[262179175] 'agreement among raft nodes before linearized reading'  (duration: 331.956956ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.536576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:16.204463Z","time spent":"332.10936ms","remote":"127.0.0.1:49192","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-08-14T10:14:16.536559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:16.201591Z","time spent":"334.889998ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25912 > 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-08-14T10:14:16.536619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.407533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:16.536671Z","caller":"traceutil/trace.go:171","msg":"trace[600908719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25987; }","duration":"281.483235ms","start":"2026-08-14T10:14:16.255174Z","end":"2026-08-14T10:14:16.536657Z","steps":["trace[600908719] 'agreement among raft nodes before linearized reading'  (duration: 281.390833ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.536686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.487186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:16.536704Z","caller":"traceutil/trace.go:171","msg":"trace[1434714724] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:25987; }","duration":"295.554478ms","start":"2026-08-14T10:14:16.241144Z","end":"2026-08-14T10:14:16.536698Z","steps":["trace[1434714724] 'agreement among raft nodes before linearized reading'  (duration: 295.518817ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.536699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.852325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-08-14T10:14:16.536722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.216414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-14T10:14:16.536752Z","caller":"traceutil/trace.go:171","msg":"trace[1104659435] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25987; }","duration":"327.948378ms","start":"2026-08-14T10:14:16.208791Z","end":"2026-08-14T10:14:16.536739Z","steps":["trace[1104659435] 'agreement among raft nodes before linearized reading'  (duration: 327.771513ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:16.536771Z","caller":"traceutil/trace.go:171","msg":"trace[1853272111] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:25987; }","duration":"116.324497ms","start":"2026-08-14T10:14:16.420435Z","end":"2026-08-14T10:14:16.53676Z","steps":["trace[1853272111] 'agreement among raft nodes before linearized reading'  (duration: 116.191544ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:16.536786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:16.208771Z","time spent":"328.0061ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-14T10:14:16.536803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.480992ms","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-08-14T10:14:16.53686Z","caller":"traceutil/trace.go:171","msg":"trace[489819854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25987; }","duration":"269.644156ms","start":"2026-08-14T10:14:16.267201Z","end":"2026-08-14T10:14:16.536845Z","steps":["trace[489819854] 'agreement among raft nodes before linearized reading'  (duration: 269.359199ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:23.251092Z","caller":"traceutil/trace.go:171","msg":"trace[145890433] transaction","detail":"{read_only:false; response_revision:26057; number_of_response:1; }","duration":"130.041373ms","start":"2026-08-14T10:14:23.121023Z","end":"2026-08-14T10:14:23.251065Z","steps":["trace[145890433] 'process raft request'  (duration: 129.892159ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:23.675933Z","caller":"traceutil/trace.go:171","msg":"trace[1512969082] transaction","detail":"{read_only:false; response_revision:26058; number_of_response:1; }","duration":"156.949138ms","start":"2026-08-14T10:14:23.518956Z","end":"2026-08-14T10:14:23.675905Z","steps":["trace[1512969082] 'process raft request'  (duration: 156.736832ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:23.974964Z","caller":"traceutil/trace.go:171","msg":"trace[1817680545] transaction","detail":"{read_only:false; response_revision:26059; number_of_response:1; }","duration":"171.489893ms","start":"2026-08-14T10:14:23.803433Z","end":"2026-08-14T10:14:23.974923Z","steps":["trace[1817680545] 'process raft request'  (duration: 171.283868ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:25.484288Z","caller":"traceutil/trace.go:171","msg":"trace[169810553] transaction","detail":"{read_only:false; response_revision:26077; number_of_response:1; }","duration":"116.675925ms","start":"2026-08-14T10:14:25.367581Z","end":"2026-08-14T10:14:25.484257Z","steps":["trace[169810553] 'process raft request'  (duration: 38.826166ms)","trace[169810553] 'compare'  (duration: 77.598573ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:25.484283Z","caller":"traceutil/trace.go:171","msg":"trace[785391165] linearizableReadLoop","detail":"{readStateIndex:26929; appliedIndex:26928; }","duration":"115.381693ms","start":"2026-08-14T10:14:25.368871Z","end":"2026-08-14T10:14:25.484252Z","steps":["trace[785391165] 'read index received'  (duration: 37.552245ms)","trace[785391165] 'applied index is now lower than readState.Index'  (duration: 77.825218ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:25.484568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.66319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e6737872-b50a-47f5-ac6d-e92cc7c1f3b8\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-08-14T10:14:25.484643Z","caller":"traceutil/trace.go:171","msg":"trace[1422915518] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e6737872-b50a-47f5-ac6d-e92cc7c1f3b8; range_end:; response_count:1; response_revision:26077; }","duration":"115.766903ms","start":"2026-08-14T10:14:25.368857Z","end":"2026-08-14T10:14:25.484624Z","steps":["trace[1422915518] 'agreement among raft nodes before linearized reading'  (duration: 115.492857ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:25.504136Z","caller":"traceutil/trace.go:171","msg":"trace[386373309] transaction","detail":"{read_only:false; response_revision:26078; number_of_response:1; }","duration":"122.684943ms","start":"2026-08-14T10:14:25.381431Z","end":"2026-08-14T10:14:25.504116Z","steps":["trace[386373309] 'process raft request'  (duration: 122.533209ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:46.820995Z","caller":"traceutil/trace.go:171","msg":"trace[1228051327] transaction","detail":"{read_only:false; response_revision:26248; number_of_response:1; }","duration":"131.618279ms","start":"2026-08-14T10:14:46.68935Z","end":"2026-08-14T10:14:46.820968Z","steps":["trace[1228051327] 'process raft request'  (duration: 131.439164ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:46.821262Z","caller":"traceutil/trace.go:171","msg":"trace[753403277] transaction","detail":"{read_only:false; response_revision:26249; number_of_response:1; }","duration":"131.035086ms","start":"2026-08-14T10:14:46.690191Z","end":"2026-08-14T10:14:46.821226Z","steps":["trace[753403277] 'process raft request'  (duration: 130.745039ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:46.821294Z","caller":"traceutil/trace.go:171","msg":"trace[511496513] linearizableReadLoop","detail":"{readStateIndex:27107; appliedIndex:27103; }","duration":"123.236926ms","start":"2026-08-14T10:14:46.698028Z","end":"2026-08-14T10:14:46.821265Z","steps":["trace[511496513] 'read index received'  (duration: 42.700661ms)","trace[511496513] 'applied index is now lower than readState.Index'  (duration: 80.535165ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:46.821437Z","caller":"traceutil/trace.go:171","msg":"trace[802431529] transaction","detail":"{read_only:false; response_revision:26250; number_of_response:1; }","duration":"130.345799ms","start":"2026-08-14T10:14:46.691066Z","end":"2026-08-14T10:14:46.821412Z","steps":["trace[802431529] 'process raft request'  (duration: 130.097203ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:46.821643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.599574ms","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-08-14T10:14:46.821669Z","caller":"traceutil/trace.go:171","msg":"trace[286912074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26250; }","duration":"123.666815ms","start":"2026-08-14T10:14:46.697995Z","end":"2026-08-14T10:14:46.821662Z","steps":["trace[286912074] 'agreement among raft nodes before linearized reading'  (duration: 123.602084ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:47.019777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.448721ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505831 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26237 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:47.020145Z","caller":"traceutil/trace.go:171","msg":"trace[606273980] transaction","detail":"{read_only:false; response_revision:26252; number_of_response:1; }","duration":"194.219657ms","start":"2026-08-14T10:14:46.82589Z","end":"2026-08-14T10:14:47.020109Z","steps":["trace[606273980] 'process raft request'  (duration: 70.345586ms)","trace[606273980] 'compare'  (duration: 123.334537ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:47.020171Z","caller":"traceutil/trace.go:171","msg":"trace[371183714] transaction","detail":"{read_only:false; response_revision:26253; number_of_response:1; }","duration":"193.446108ms","start":"2026-08-14T10:14:46.826703Z","end":"2026-08-14T10:14:47.020149Z","steps":["trace[371183714] 'process raft request'  (duration: 193.339916ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:47.02037Z","caller":"traceutil/trace.go:171","msg":"trace[602889537] transaction","detail":"{read_only:false; response_revision:26254; number_of_response:1; }","duration":"171.484062ms","start":"2026-08-14T10:14:46.848868Z","end":"2026-08-14T10:14:47.020352Z","steps":["trace[602889537] 'process raft request'  (duration: 171.240166ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:47.236598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.690753ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505834 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26240 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:47.236797Z","caller":"traceutil/trace.go:171","msg":"trace[395685393] transaction","detail":"{read_only:false; response_revision:26255; number_of_response:1; }","duration":"232.769557ms","start":"2026-08-14T10:14:47.004006Z","end":"2026-08-14T10:14:47.236775Z","steps":["trace[395685393] 'process raft request'  (duration: 118.794417ms)","trace[395685393] 'compare'  (duration: 113.55432ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:47.237303Z","caller":"traceutil/trace.go:171","msg":"trace[1951546490] transaction","detail":"{read_only:false; response_revision:26256; number_of_response:1; }","duration":"211.044797ms","start":"2026-08-14T10:14:47.02622Z","end":"2026-08-14T10:14:47.237265Z","steps":["trace[1951546490] 'process raft request'  (duration: 210.498904ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:48.357024Z","caller":"traceutil/trace.go:171","msg":"trace[2095162532] transaction","detail":"{read_only:false; response_revision:26260; number_of_response:1; }","duration":"140.728732ms","start":"2026-08-14T10:14:48.21627Z","end":"2026-08-14T10:14:48.356998Z","steps":["trace[2095162532] 'process raft request'  (duration: 140.308812ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:48.960831Z","caller":"traceutil/trace.go:171","msg":"trace[2088877313] transaction","detail":"{read_only:false; response_revision:26264; number_of_response:1; }","duration":"131.558268ms","start":"2026-08-14T10:14:48.829248Z","end":"2026-08-14T10:14:48.960807Z","steps":["trace[2088877313] 'process raft request'  (duration: 93.532231ms)","trace[2088877313] 'compare'  (duration: 37.814812ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:48.960944Z","caller":"traceutil/trace.go:171","msg":"trace[2121022591] linearizableReadLoop","detail":"{readStateIndex:27122; appliedIndex:27120; }","duration":"125.243324ms","start":"2026-08-14T10:14:48.835672Z","end":"2026-08-14T10:14:48.960915Z","steps":["trace[2121022591] 'read index received'  (duration: 87.065193ms)","trace[2121022591] 'applied index is now lower than readState.Index'  (duration: 38.176371ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:48.961042Z","caller":"traceutil/trace.go:171","msg":"trace[1056756864] transaction","detail":"{read_only:false; response_revision:26265; number_of_response:1; }","duration":"131.664741ms","start":"2026-08-14T10:14:48.829339Z","end":"2026-08-14T10:14:48.961003Z","steps":["trace[1056756864] 'process raft request'  (duration: 131.436485ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:48.961155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.47366ms","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-08-14T10:14:48.961239Z","caller":"traceutil/trace.go:171","msg":"trace[191315850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26265; }","duration":"125.586453ms","start":"2026-08-14T10:14:48.835634Z","end":"2026-08-14T10:14:48.96122Z","steps":["trace[191315850] 'agreement among raft nodes before linearized reading'  (duration: 125.402528ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:49.149803Z","caller":"traceutil/trace.go:171","msg":"trace[88747782] transaction","detail":"{read_only:false; response_revision:26268; number_of_response:1; }","duration":"122.661191ms","start":"2026-08-14T10:14:49.027118Z","end":"2026-08-14T10:14:49.149779Z","steps":["trace[88747782] 'process raft request'  (duration: 122.629231ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:49.150217Z","caller":"traceutil/trace.go:171","msg":"trace[1531800936] transaction","detail":"{read_only:false; response_revision:26267; number_of_response:1; }","duration":"123.145364ms","start":"2026-08-14T10:14:49.027063Z","end":"2026-08-14T10:14:49.150208Z","steps":["trace[1531800936] 'process raft request'  (duration: 51.452345ms)","trace[1531800936] 'compare'  (duration: 71.118215ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:49.371506Z","caller":"traceutil/trace.go:171","msg":"trace[2028013775] transaction","detail":"{read_only:false; response_revision:26269; number_of_response:1; }","duration":"129.58403ms","start":"2026-08-14T10:14:49.24188Z","end":"2026-08-14T10:14:49.371464Z","steps":["trace[2028013775] 'process raft request'  (duration: 109.038819ms)","trace[2028013775] 'compare'  (duration: 20.354786ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:49.387463Z","caller":"traceutil/trace.go:171","msg":"trace[328197339] transaction","detail":"{read_only:false; response_revision:26270; number_of_response:1; }","duration":"143.4823ms","start":"2026-08-14T10:14:49.24395Z","end":"2026-08-14T10:14:49.387433Z","steps":["trace[328197339] 'process raft request'  (duration: 143.308706ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:49.387669Z","caller":"traceutil/trace.go:171","msg":"trace[1477864915] linearizableReadLoop","detail":"{readStateIndex:27127; appliedIndex:27125; }","duration":"135.111285ms","start":"2026-08-14T10:14:49.252547Z","end":"2026-08-14T10:14:49.387659Z","steps":["trace[1477864915] 'read index received'  (duration: 98.380259ms)","trace[1477864915] 'applied index is now lower than readState.Index'  (duration: 36.729816ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:49.387828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.266018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:49.387911Z","caller":"traceutil/trace.go:171","msg":"trace[124765355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26270; }","duration":"135.396851ms","start":"2026-08-14T10:14:49.252495Z","end":"2026-08-14T10:14:49.387892Z","steps":["trace[124765355] 'agreement among raft nodes before linearized reading'  (duration: 135.267418ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:49.388912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.329573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-08-14T10:14:49.388948Z","caller":"traceutil/trace.go:171","msg":"trace[665798969] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26270; }","duration":"113.405986ms","start":"2026-08-14T10:14:49.275534Z","end":"2026-08-14T10:14:49.38894Z","steps":["trace[665798969] 'agreement among raft nodes before linearized reading'  (duration: 112.282209ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:50.30811Z","caller":"traceutil/trace.go:171","msg":"trace[1295585406] transaction","detail":"{read_only:false; response_revision:26272; number_of_response:1; }","duration":"127.597581ms","start":"2026-08-14T10:14:50.180487Z","end":"2026-08-14T10:14:50.308085Z","steps":["trace[1295585406] 'process raft request'  (duration: 127.213042ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:50.59564Z","caller":"traceutil/trace.go:171","msg":"trace[937724252] transaction","detail":"{read_only:false; response_revision:26273; number_of_response:1; }","duration":"287.309898ms","start":"2026-08-14T10:14:50.308277Z","end":"2026-08-14T10:14:50.595587Z","steps":["trace[937724252] 'process raft request'  (duration: 206.822795ms)","trace[937724252] 'compare'  (duration: 80.290058ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:50.606882Z","caller":"traceutil/trace.go:171","msg":"trace[769221135] transaction","detail":"{read_only:false; response_revision:26274; number_of_response:1; }","duration":"245.612191ms","start":"2026-08-14T10:14:50.361243Z","end":"2026-08-14T10:14:50.606855Z","steps":["trace[769221135] 'process raft request'  (duration: 245.417856ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:50.71737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.525035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505879 > lease_revoke:<id:27559fff94fa53e3>","response":"size:29"}
{"level":"info","ts":"2026-08-14T10:14:50.717459Z","caller":"traceutil/trace.go:171","msg":"trace[264219889] linearizableReadLoop","detail":"{readStateIndex:27132; appliedIndex:27130; }","duration":"176.541375ms","start":"2026-08-14T10:14:50.540902Z","end":"2026-08-14T10:14:50.717444Z","steps":["trace[264219889] 'read index received'  (duration: 65.792825ms)","trace[264219889] 'applied index is now lower than readState.Index'  (duration: 110.74729ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:50.717525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.612578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:50.717553Z","caller":"traceutil/trace.go:171","msg":"trace[1460713656] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:26274; }","duration":"176.68803ms","start":"2026-08-14T10:14:50.540855Z","end":"2026-08-14T10:14:50.717543Z","steps":["trace[1460713656] 'agreement among raft nodes before linearized reading'  (duration: 176.627188ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:50.948163Z","caller":"traceutil/trace.go:171","msg":"trace[1622752800] transaction","detail":"{read_only:false; response_revision:26276; number_of_response:1; }","duration":"108.508236ms","start":"2026-08-14T10:14:50.839627Z","end":"2026-08-14T10:14:50.948135Z","steps":["trace[1622752800] 'process raft request'  (duration: 107.539042ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:51.116642Z","caller":"traceutil/trace.go:171","msg":"trace[179438751] transaction","detail":"{read_only:false; response_revision:26279; number_of_response:1; }","duration":"104.412566ms","start":"2026-08-14T10:14:51.012201Z","end":"2026-08-14T10:14:51.116613Z","steps":["trace[179438751] 'process raft request'  (duration: 58.61717ms)","trace[179438751] 'compare'  (duration: 45.678064ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:51.340558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.711434ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505894 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26268 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:51.340764Z","caller":"traceutil/trace.go:171","msg":"trace[363731153] transaction","detail":"{read_only:false; response_revision:26280; number_of_response:1; }","duration":"183.586898ms","start":"2026-08-14T10:14:51.157146Z","end":"2026-08-14T10:14:51.340733Z","steps":["trace[363731153] 'process raft request'  (duration: 62.572026ms)","trace[363731153] 'compare'  (duration: 120.557991ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:51.373231Z","caller":"traceutil/trace.go:171","msg":"trace[676247351] transaction","detail":"{read_only:false; response_revision:26281; number_of_response:1; }","duration":"214.737827ms","start":"2026-08-14T10:14:51.158457Z","end":"2026-08-14T10:14:51.373195Z","steps":["trace[676247351] 'process raft request'  (duration: 214.366988ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:51.373409Z","caller":"traceutil/trace.go:171","msg":"trace[938774053] linearizableReadLoop","detail":"{readStateIndex:27140; appliedIndex:27138; }","duration":"114.682627ms","start":"2026-08-14T10:14:51.258699Z","end":"2026-08-14T10:14:51.373382Z","steps":["trace[938774053] 'read index received'  (duration: 114.157363ms)","trace[938774053] 'applied index is now lower than readState.Index'  (duration: 524.364µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:51.373527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.81546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:51.373564Z","caller":"traceutil/trace.go:171","msg":"trace[950645244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26282; }","duration":"114.913922ms","start":"2026-08-14T10:14:51.258642Z","end":"2026-08-14T10:14:51.373556Z","steps":["trace[950645244] 'agreement among raft nodes before linearized reading'  (duration: 114.8272ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:51.373437Z","caller":"traceutil/trace.go:171","msg":"trace[1557927209] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"186.54713ms","start":"2026-08-14T10:14:51.186875Z","end":"2026-08-14T10:14:51.373422Z","steps":["trace[1557927209] 'process raft request'  (duration: 186.265873ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:51.609029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.347732ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505901 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26270 > 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-08-14T10:14:51.609227Z","caller":"traceutil/trace.go:171","msg":"trace[1201746425] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"182.45475ms","start":"2026-08-14T10:14:51.426738Z","end":"2026-08-14T10:14:51.609193Z","steps":["trace[1201746425] 'process raft request'  (duration: 71.876973ms)","trace[1201746425] 'compare'  (duration: 110.107825ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:52.294774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.335874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18353"}
{"level":"info","ts":"2026-08-14T10:14:52.29485Z","caller":"traceutil/trace.go:171","msg":"trace[1339493442] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26285; }","duration":"163.451896ms","start":"2026-08-14T10:14:52.131381Z","end":"2026-08-14T10:14:52.294833Z","steps":["trace[1339493442] 'range keys from in-memory index tree'  (duration: 163.174219ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:52.322927Z","caller":"traceutil/trace.go:171","msg":"trace[1353755900] transaction","detail":"{read_only:false; response_revision:26286; number_of_response:1; }","duration":"105.054043ms","start":"2026-08-14T10:14:52.217837Z","end":"2026-08-14T10:14:52.322891Z","steps":["trace[1353755900] 'process raft request'  (duration: 104.92762ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:52.529918Z","caller":"traceutil/trace.go:171","msg":"trace[939264775] transaction","detail":"{read_only:false; response_revision:26287; number_of_response:1; }","duration":"216.587812ms","start":"2026-08-14T10:14:52.313295Z","end":"2026-08-14T10:14:52.529883Z","steps":["trace[939264775] 'process raft request'  (duration: 191.226864ms)","trace[939264775] 'compare'  (duration: 25.102582ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:52.779119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.204313ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505911 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26274 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:52.77957Z","caller":"traceutil/trace.go:171","msg":"trace[1307756392] transaction","detail":"{read_only:false; response_revision:26289; number_of_response:1; }","duration":"166.985553ms","start":"2026-08-14T10:14:52.612565Z","end":"2026-08-14T10:14:52.779551Z","steps":["trace[1307756392] 'process raft request'  (duration: 41.263477ms)","trace[1307756392] 'compare'  (duration: 125.080189ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:52.986945Z","caller":"traceutil/trace.go:171","msg":"trace[683159051] transaction","detail":"{read_only:false; response_revision:26290; number_of_response:1; }","duration":"189.43586ms","start":"2026-08-14T10:14:52.797481Z","end":"2026-08-14T10:14:52.986917Z","steps":["trace[683159051] 'process raft request'  (duration: 131.087957ms)","trace[683159051] 'compare'  (duration: 57.649345ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:53.325538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.299504ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505917 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26278 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:53.325645Z","caller":"traceutil/trace.go:171","msg":"trace[544117813] linearizableReadLoop","detail":"{readStateIndex:27151; appliedIndex:27149; }","duration":"308.093024ms","start":"2026-08-14T10:14:53.017535Z","end":"2026-08-14T10:14:53.325628Z","steps":["trace[544117813] 'read index received'  (duration: 68.032268ms)","trace[544117813] 'applied index is now lower than readState.Index'  (duration: 240.059266ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:53.32588Z","caller":"traceutil/trace.go:171","msg":"trace[1511807755] transaction","detail":"{read_only:false; response_revision:26293; number_of_response:1; }","duration":"319.934043ms","start":"2026-08-14T10:14:53.005933Z","end":"2026-08-14T10:14:53.325867Z","steps":["trace[1511807755] 'process raft request'  (duration: 119.222418ms)","trace[1511807755] 'compare'  (duration: 200.033458ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:53.325927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.005911Z","time spent":"319.991825ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26278 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-14T10:14:53.325974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.414399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-14T10:14:53.326009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.456073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"}
{"level":"info","ts":"2026-08-14T10:14:53.326089Z","caller":"traceutil/trace.go:171","msg":"trace[642261607] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:26293; }","duration":"308.589466ms","start":"2026-08-14T10:14:53.017477Z","end":"2026-08-14T10:14:53.326067Z","steps":["trace[642261607] 'agreement among raft nodes before linearized reading'  (duration: 308.369981ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.32613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.017454Z","time spent":"308.668187ms","remote":"127.0.0.1:49066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1657,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "}
{"level":"info","ts":"2026-08-14T10:14:53.326071Z","caller":"traceutil/trace.go:171","msg":"trace[918088837] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:26293; }","duration":"289.540103ms","start":"2026-08-14T10:14:53.036507Z","end":"2026-08-14T10:14:53.326047Z","steps":["trace[918088837] 'agreement among raft nodes before linearized reading'  (duration: 289.381489ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.326161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.313583ms","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-08-14T10:14:53.326185Z","caller":"traceutil/trace.go:171","msg":"trace[1329307427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26293; }","duration":"204.369775ms","start":"2026-08-14T10:14:53.12181Z","end":"2026-08-14T10:14:53.32618Z","steps":["trace[1329307427] 'agreement among raft nodes before linearized reading'  (duration: 204.283463ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.327218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.053676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:273011"}
{"level":"info","ts":"2026-08-14T10:14:53.327274Z","caller":"traceutil/trace.go:171","msg":"trace[1018606643] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:26293; }","duration":"229.159769ms","start":"2026-08-14T10:14:53.098101Z","end":"2026-08-14T10:14:53.32726Z","steps":["trace[1018606643] 'agreement among raft nodes before linearized reading'  (duration: 228.007341ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.803973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.487175ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564505923 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26279 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:14:53.80422Z","caller":"traceutil/trace.go:171","msg":"trace[105137278] transaction","detail":"{read_only:false; response_revision:26296; number_of_response:1; }","duration":"377.471515ms","start":"2026-08-14T10:14:53.426703Z","end":"2026-08-14T10:14:53.804174Z","steps":["trace[105137278] 'process raft request'  (duration: 377.429574ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.804288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.426684Z","time spent":"377.574167ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26283 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-14T10:14:53.804432Z","caller":"traceutil/trace.go:171","msg":"trace[1076379585] transaction","detail":"{read_only:false; response_revision:26294; number_of_response:1; }","duration":"474.245955ms","start":"2026-08-14T10:14:53.330135Z","end":"2026-08-14T10:14:53.804381Z","steps":["trace[1076379585] 'process raft request'  (duration: 176.272409ms)","trace[1076379585] 'compare'  (duration: 296.558542ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:53.804589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.330119Z","time spent":"474.3919ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26279 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-14T10:14:53.8046Z","caller":"traceutil/trace.go:171","msg":"trace[589961088] transaction","detail":"{read_only:false; response_revision:26295; number_of_response:1; }","duration":"410.664135ms","start":"2026-08-14T10:14:53.393892Z","end":"2026-08-14T10:14:53.804557Z","steps":["trace[589961088] 'process raft request'  (duration: 410.185373ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:53.804691Z","caller":"traceutil/trace.go:171","msg":"trace[1763681285] linearizableReadLoop","detail":"{readStateIndex:27152; appliedIndex:27151; }","duration":"459.630411ms","start":"2026-08-14T10:14:53.345046Z","end":"2026-08-14T10:14:53.804676Z","steps":["trace[1763681285] 'read index received'  (duration: 161.372396ms)","trace[1763681285] 'applied index is now lower than readState.Index'  (duration: 298.256014ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:14:53.804802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.393876Z","time spent":"410.836449ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:26261 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-14T10:14:53.80485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.798545ms","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-08-14T10:14:53.804877Z","caller":"traceutil/trace.go:171","msg":"trace[1096032285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26296; }","duration":"459.840355ms","start":"2026-08-14T10:14:53.34503Z","end":"2026-08-14T10:14:53.804871Z","steps":["trace[1096032285] 'agreement among raft nodes before linearized reading'  (duration: 459.729493ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.804902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.345024Z","time spent":"459.874176ms","remote":"127.0.0.1:49192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-14T10:14:53.805058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.290147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-08-14T10:14:53.805073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.527723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-14T10:14:53.805084Z","caller":"traceutil/trace.go:171","msg":"trace[1947159424] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26296; }","duration":"246.336548ms","start":"2026-08-14T10:14:53.558741Z","end":"2026-08-14T10:14:53.805078Z","steps":["trace[1947159424] 'agreement among raft nodes before linearized reading'  (duration: 246.281847ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:53.805095Z","caller":"traceutil/trace.go:171","msg":"trace[1535814190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26296; }","duration":"426.572434ms","start":"2026-08-14T10:14:53.378517Z","end":"2026-08-14T10:14:53.805089Z","steps":["trace[1535814190] 'agreement among raft nodes before linearized reading'  (duration: 426.486152ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.805113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T10:14:53.378504Z","time spent":"426.606415ms","remote":"127.0.0.1:49192","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-08-14T10:14:53.805173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.59444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-14T10:14:53.805191Z","caller":"traceutil/trace.go:171","msg":"trace[1780011041] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:26296; }","duration":"261.648172ms","start":"2026-08-14T10:14:53.543537Z","end":"2026-08-14T10:14:53.805185Z","steps":["trace[1780011041] 'agreement among raft nodes before linearized reading'  (duration: 261.616791ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:53.805225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.895591ms","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-08-14T10:14:53.80525Z","caller":"traceutil/trace.go:171","msg":"trace[826031962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26296; }","duration":"191.950171ms","start":"2026-08-14T10:14:53.613294Z","end":"2026-08-14T10:14:53.805244Z","steps":["trace[826031962] 'agreement among raft nodes before linearized reading'  (duration: 191.89045ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:54.023185Z","caller":"traceutil/trace.go:171","msg":"trace[1077894042] transaction","detail":"{read_only:false; response_revision:26297; number_of_response:1; }","duration":"211.633932ms","start":"2026-08-14T10:14:53.81152Z","end":"2026-08-14T10:14:54.023154Z","steps":["trace[1077894042] 'process raft request'  (duration: 200.080779ms)","trace[1077894042] 'compare'  (duration: 11.344127ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:54.023449Z","caller":"traceutil/trace.go:171","msg":"trace[953801259] linearizableReadLoop","detail":"{readStateIndex:27156; appliedIndex:27154; }","duration":"211.452257ms","start":"2026-08-14T10:14:53.811973Z","end":"2026-08-14T10:14:54.023426Z","steps":["trace[953801259] 'read index received'  (duration: 199.641559ms)","trace[953801259] 'applied index is now lower than readState.Index'  (duration: 11.809808ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:14:54.023488Z","caller":"traceutil/trace.go:171","msg":"trace[1272167827] transaction","detail":"{read_only:false; response_revision:26298; number_of_response:1; }","duration":"211.909218ms","start":"2026-08-14T10:14:53.811569Z","end":"2026-08-14T10:14:54.023478Z","steps":["trace[1272167827] 'process raft request'  (duration: 211.692113ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:14:54.023677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.691143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-08-14T10:14:54.023668Z","caller":"traceutil/trace.go:171","msg":"trace[1178252429] transaction","detail":"{read_only:false; response_revision:26299; number_of_response:1; }","duration":"210.854433ms","start":"2026-08-14T10:14:53.812785Z","end":"2026-08-14T10:14:54.023639Z","steps":["trace[1178252429] 'process raft request'  (duration: 210.581057ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:14:54.023707Z","caller":"traceutil/trace.go:171","msg":"trace[1270707838] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26300; }","duration":"211.754505ms","start":"2026-08-14T10:14:53.811946Z","end":"2026-08-14T10:14:54.023701Z","steps":["trace[1270707838] 'agreement among raft nodes before linearized reading'  (duration: 211.688033ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:15:04.020836Z","caller":"traceutil/trace.go:171","msg":"trace[561928941] linearizableReadLoop","detail":"{readStateIndex:27255; appliedIndex:27254; }","duration":"175.882759ms","start":"2026-08-14T10:15:03.844926Z","end":"2026-08-14T10:15:04.020809Z","steps":["trace[561928941] 'read index received'  (duration: 175.697165ms)","trace[561928941] 'applied index is now lower than readState.Index'  (duration: 184.594µs)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:15:04.020954Z","caller":"traceutil/trace.go:171","msg":"trace[517681425] transaction","detail":"{read_only:false; response_revision:26395; number_of_response:1; }","duration":"176.810042ms","start":"2026-08-14T10:15:03.844132Z","end":"2026-08-14T10:15:04.020942Z","steps":["trace[517681425] 'process raft request'  (duration: 176.542106ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:15:04.021197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.261988ms","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-08-14T10:15:04.021237Z","caller":"traceutil/trace.go:171","msg":"trace[1243718850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26395; }","duration":"176.35869ms","start":"2026-08-14T10:15:03.844869Z","end":"2026-08-14T10:15:04.021227Z","steps":["trace[1243718850] 'agreement among raft nodes before linearized reading'  (duration: 176.214507ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:15:04.224416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.655485ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2834347460564506134 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26370 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-14T10:15:04.224559Z","caller":"traceutil/trace.go:171","msg":"trace[522355729] linearizableReadLoop","detail":"{readStateIndex:27256; appliedIndex:27255; }","duration":"165.918416ms","start":"2026-08-14T10:15:04.058617Z","end":"2026-08-14T10:15:04.224535Z","steps":["trace[522355729] 'read index received'  (duration: 65.013255ms)","trace[522355729] 'applied index is now lower than readState.Index'  (duration: 100.903451ms)"],"step_count":2}
{"level":"info","ts":"2026-08-14T10:15:04.224658Z","caller":"traceutil/trace.go:171","msg":"trace[831451910] transaction","detail":"{read_only:false; response_revision:26396; number_of_response:1; }","duration":"199.261389ms","start":"2026-08-14T10:15:04.02536Z","end":"2026-08-14T10:15:04.224622Z","steps":["trace[831451910] 'process raft request'  (duration: 98.267796ms)","trace[831451910] 'compare'  (duration: 100.421879ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-14T10:15:04.224792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.134061ms","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-08-14T10:15:04.224871Z","caller":"traceutil/trace.go:171","msg":"trace[115147825] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26396; }","duration":"166.275755ms","start":"2026-08-14T10:15:04.058579Z","end":"2026-08-14T10:15:04.224855Z","steps":["trace[115147825] 'agreement among raft nodes before linearized reading'  (duration: 166.101471ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:15:04.225311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.244363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-08-14T10:15:04.225425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.082608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-14T10:15:04.225518Z","caller":"traceutil/trace.go:171","msg":"trace[1886639243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26396; }","duration":"138.20996ms","start":"2026-08-14T10:15:04.087289Z","end":"2026-08-14T10:15:04.225499Z","steps":["trace[1886639243] 'agreement among raft nodes before linearized reading'  (duration: 137.934064ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-14T10:15:04.225524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.6426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-14T10:15:04.225559Z","caller":"traceutil/trace.go:171","msg":"trace[740883580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26396; }","duration":"147.726792ms","start":"2026-08-14T10:15:04.077824Z","end":"2026-08-14T10:15:04.225551Z","steps":["trace[740883580] 'agreement among raft nodes before linearized reading'  (duration: 147.60668ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:15:04.225389Z","caller":"traceutil/trace.go:171","msg":"trace[1432273705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26396; }","duration":"150.338526ms","start":"2026-08-14T10:15:04.075035Z","end":"2026-08-14T10:15:04.225374Z","steps":["trace[1432273705] 'agreement among raft nodes before linearized reading'  (duration: 150.022139ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:15:04.689101Z","caller":"traceutil/trace.go:171","msg":"trace[964741231] transaction","detail":"{read_only:false; response_revision:26401; number_of_response:1; }","duration":"125.803178ms","start":"2026-08-14T10:15:04.563256Z","end":"2026-08-14T10:15:04.68906Z","steps":["trace[964741231] 'process raft request'  (duration: 125.560632ms)"],"step_count":1}
{"level":"info","ts":"2026-08-14T10:18:01.9458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25230}
{"level":"info","ts":"2026-08-14T10:18:02.07556Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25230,"took":"125.470578ms","hash":2920777212,"current-db-size-bytes":60735488,"current-db-size":"61 MB","current-db-size-in-use-bytes":38338560,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-08-14T10:18:02.075625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2920777212,"revision":25230,"compact-revision":21998}
{"level":"info","ts":"2026-08-14T10:19:39.168272Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-14T10:19:39.173261Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-14T10:19:39.173423Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-08-14T10:23:01.952563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28215}
{"level":"info","ts":"2026-08-14T10:23:02.07739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28215,"took":"121.539112ms","hash":2108618315,"current-db-size-bytes":60735488,"current-db-size":"61 MB","current-db-size-in-use-bytes":33124352,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-14T10:23:02.077453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2108618315,"revision":28215,"compact-revision":25230}
{"level":"info","ts":"2026-08-14T10:28:01.957841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30598}
{"level":"info","ts":"2026-08-14T10:28:02.083591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30598,"took":"121.921041ms","hash":2911401815,"current-db-size-bytes":60735488,"current-db-size":"61 MB","current-db-size-in-use-bytes":30642176,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-14T10:28:02.083645Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2911401815,"revision":30598,"compact-revision":28215}
{"level":"info","ts":"2026-08-14T10:33:01.963947Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32857}
{"level":"info","ts":"2026-08-14T10:33:02.118284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32857,"took":"150.390456ms","hash":2554651346,"current-db-size-bytes":61779968,"current-db-size":"62 MB","current-db-size-in-use-bytes":30990336,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-14T10:33:02.11836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2554651346,"revision":32857,"compact-revision":30598}
{"level":"info","ts":"2026-08-14T10:38:01.969781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35123}
{"level":"info","ts":"2026-08-14T10:38:02.141142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35123,"took":"167.082782ms","hash":3193163644,"current-db-size-bytes":61779968,"current-db-size":"62 MB","current-db-size-in-use-bytes":32468992,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-14T10:38:02.141212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3193163644,"revision":35123,"compact-revision":32857}
{"level":"info","ts":"2026-08-14T10:41:04.001891Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-14T10:41:04.006175Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-08-14T10:41:04.006362Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-08-14T10:43:01.976857Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37385}
{"level":"info","ts":"2026-08-14T10:43:02.091458Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37385,"took":"111.605819ms","hash":2118960387,"current-db-size-bytes":61779968,"current-db-size":"62 MB","current-db-size-in-use-bytes":32210944,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-14T10:43:02.091524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2118960387,"revision":37385,"compact-revision":35123}