{"level":"warn","ts":"2026-05-25T10:13:29.937423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-25T10:13:29.937551Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.212: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.212:2380","--initial-cluster=instance=https://199.19.213.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.212:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-25T10:13:29.937642Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-25T10:13:29.937654Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.212:2380"]}
{"level":"info","ts":"2026-05-25T10:13:29.937677Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-25T10:13:29.938641Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"]}
{"level":"info","ts":"2026-05-25T10:13:29.938781Z","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.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.212:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-25T10:13:30.030396Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"59.578701ms"}
{"level":"info","ts":"2026-05-25T10:13:30.047949Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e1ab0380b9290bdc","cluster-id":"a3ed131e36ad6843"}
{"level":"info","ts":"2026-05-25T10:13:30.048141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=()"}
{"level":"info","ts":"2026-05-25T10:13:30.048183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 0"}
{"level":"info","ts":"2026-05-25T10:13:30.048208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e1ab0380b9290bdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-25T10:13:30.048222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 1"}
{"level":"info","ts":"2026-05-25T10:13:30.048276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"}
{"level":"warn","ts":"2026-05-25T10:13:30.064177Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-25T10:13:30.067568Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-25T10:13:30.069301Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-25T10:13:30.072765Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e1ab0380b9290bdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-25T10:13:30.073018Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e1ab0380b9290bdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-25T10:13:30.073117Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-25T10:13:30.073274Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-25T10:13:30.073294Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-25T10:13:30.074988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"}
{"level":"info","ts":"2026-05-25T10:13:30.075688Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","added-peer-id":"e1ab0380b9290bdc","added-peer-peer-urls":["https://199.19.213.212:2380"]}
{"level":"info","ts":"2026-05-25T10:13:30.077631Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-25T10:13:30.077809Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.212:2380"}
{"level":"info","ts":"2026-05-25T10:13:30.077867Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.212:2380"}
{"level":"info","ts":"2026-05-25T10:13:30.077934Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e1ab0380b9290bdc","initial-advertise-peer-urls":["https://199.19.213.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-25T10:13:30.07799Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-25T10:13:30.248982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc is starting a new election at term 1"}
{"level":"info","ts":"2026-05-25T10:13:30.249084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-25T10:13:30.249126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgPreVoteResp from e1ab0380b9290bdc at term 1"}
{"level":"info","ts":"2026-05-25T10:13:30.249151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became candidate at term 2"}
{"level":"info","ts":"2026-05-25T10:13:30.249169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgVoteResp from e1ab0380b9290bdc at term 2"}
{"level":"info","ts":"2026-05-25T10:13:30.249185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became leader at term 2"}
{"level":"info","ts":"2026-05-25T10:13:30.249205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e1ab0380b9290bdc elected leader e1ab0380b9290bdc at term 2"}
{"level":"info","ts":"2026-05-25T10:13:30.250426Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T10:13:30.251226Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e1ab0380b9290bdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.212:2379]}","request-path":"/0/members/e1ab0380b9290bdc/attributes","cluster-id":"a3ed131e36ad6843","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-25T10:13:30.251267Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-25T10:13:30.251382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-25T10:13:30.25159Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-25T10:13:30.251638Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-25T10:13:30.251741Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T10:13:30.251894Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T10:13:30.251943Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-25T10:13:30.255402Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-25T10:13:30.255469Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.212:2379"}
{"level":"warn","ts":"2026-05-25T10:13:35.245545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.306445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3713"}
{"level":"warn","ts":"2026-05-25T10:13:35.245661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.223788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-05-25T10:13:35.245769Z","caller":"traceutil/trace.go:171","msg":"trace[238373335] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:261; }","duration":"165.607752ms","start":"2026-05-25T10:13:35.080136Z","end":"2026-05-25T10:13:35.245744Z","steps":["trace[238373335] 'range keys from in-memory index tree'  (duration: 165.158742ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:13:35.245831Z","caller":"traceutil/trace.go:171","msg":"trace[75899222] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:261; }","duration":"194.425933ms","start":"2026-05-25T10:13:35.051341Z","end":"2026-05-25T10:13:35.245767Z","steps":["trace[75899222] 'range keys from in-memory index tree'  (duration: 194.088376ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:13:43.576844Z","caller":"traceutil/trace.go:171","msg":"trace[871617891] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"106.249235ms","start":"2026-05-25T10:13:43.470568Z","end":"2026-05-25T10:13:43.576817Z","steps":["trace[871617891] 'process raft request'  (duration: 106.055751ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:13:43.874905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.249073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.212\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-05-25T10:13:43.874928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.240281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"}
{"level":"info","ts":"2026-05-25T10:13:43.875025Z","caller":"traceutil/trace.go:171","msg":"trace[1548099181] range","detail":"{range_begin:/registry/masterleases/199.19.213.212; range_end:; response_count:1; response_revision:401; }","duration":"156.359985ms","start":"2026-05-25T10:13:43.718642Z","end":"2026-05-25T10:13:43.875002Z","steps":["trace[1548099181] 'range keys from in-memory index tree'  (duration: 156.16078ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:13:43.875134Z","caller":"traceutil/trace.go:171","msg":"trace[1534488081] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:401; }","duration":"111.514746ms","start":"2026-05-25T10:13:43.76355Z","end":"2026-05-25T10:13:43.875065Z","steps":["trace[1534488081] 'range keys from in-memory index tree'  (duration: 111.110468ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:13:44.063862Z","caller":"traceutil/trace.go:171","msg":"trace[2115813161] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"156.1293ms","start":"2026-05-25T10:13:43.907706Z","end":"2026-05-25T10:13:44.063835Z","steps":["trace[2115813161] 'process raft request'  (duration: 156.046928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:13:44.063892Z","caller":"traceutil/trace.go:171","msg":"trace[2113027124] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"179.925556ms","start":"2026-05-25T10:13:43.883933Z","end":"2026-05-25T10:13:44.063859Z","steps":["trace[2113027124] 'process raft request'  (duration: 160.435033ms)","trace[2113027124] 'compare'  (duration: 19.200287ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:13:44.426325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.720072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T10:13:44.426426Z","caller":"traceutil/trace.go:171","msg":"trace[2045647011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:403; }","duration":"142.882407ms","start":"2026-05-25T10:13:44.283521Z","end":"2026-05-25T10:13:44.426403Z","steps":["trace[2045647011] 'range keys from in-memory index tree'  (duration: 142.60858ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:14:11.516846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.022381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T10:14:11.516962Z","caller":"traceutil/trace.go:171","msg":"trace[887184671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"234.206764ms","start":"2026-05-25T10:14:11.28273Z","end":"2026-05-25T10:14:11.516937Z","steps":["trace[887184671] 'range keys from in-memory index tree'  (duration: 233.878968ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:14:15.212366Z","caller":"traceutil/trace.go:171","msg":"trace[132682468] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"107.557639ms","start":"2026-05-25T10:14:15.104365Z","end":"2026-05-25T10:14:15.211923Z","steps":["trace[132682468] 'process raft request'  (duration: 104.809076ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:14:59.316707Z","caller":"traceutil/trace.go:171","msg":"trace[1862301535] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"185.28002ms","start":"2026-05-25T10:14:59.131385Z","end":"2026-05-25T10:14:59.316665Z","steps":["trace[1862301535] 'process raft request'  (duration: 185.119076ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:15:20.706254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.868246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend\" ","response":"range_response_count:1 size:1041"}
{"level":"info","ts":"2026-05-25T10:15:20.706355Z","caller":"traceutil/trace.go:171","msg":"trace[890562533] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend; range_end:; response_count:1; response_revision:1422; }","duration":"101.283433ms","start":"2026-05-25T10:15:20.605047Z","end":"2026-05-25T10:15:20.70633Z","steps":["trace[890562533] 'range keys from in-memory index tree'  (duration: 100.702212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:15:49.964426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.005518ms","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":"warn","ts":"2026-05-25T10:15:49.96444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.01287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-25T10:15:49.964527Z","caller":"traceutil/trace.go:171","msg":"trace[744587515] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1875; }","duration":"279.17776ms","start":"2026-05-25T10:15:49.685326Z","end":"2026-05-25T10:15:49.964504Z","steps":["trace[744587515] 'range keys from in-memory index tree'  (duration: 278.766723ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:15:49.964528Z","caller":"traceutil/trace.go:171","msg":"trace[213413604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1875; }","duration":"325.153172ms","start":"2026-05-25T10:15:49.639359Z","end":"2026-05-25T10:15:49.964512Z","steps":["trace[213413604] 'range keys from in-memory index tree'  (duration: 324.860356ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:15:49.964636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.084491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-25T10:15:49.964657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.019481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-05-25T10:15:49.964572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:15:49.639325Z","time spent":"325.239003ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-25T10:15:49.96475Z","caller":"traceutil/trace.go:171","msg":"trace[9595904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1875; }","duration":"114.292204ms","start":"2026-05-25T10:15:49.850429Z","end":"2026-05-25T10:15:49.964721Z","steps":["trace[9595904] 'range keys from in-memory index tree'  (duration: 113.802855ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:15:49.96476Z","caller":"traceutil/trace.go:171","msg":"trace[1415642929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1875; }","duration":"210.181664ms","start":"2026-05-25T10:15:49.754554Z","end":"2026-05-25T10:15:49.964736Z","steps":["trace[1415642929] 'range keys from in-memory index tree'  (duration: 209.798126ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:21:56.46263Z","caller":"traceutil/trace.go:171","msg":"trace[1124542034] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"118.85594ms","start":"2026-05-25T10:21:56.343738Z","end":"2026-05-25T10:21:56.462594Z","steps":["trace[1124542034] 'process raft request'  (duration: 118.452942ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:21:56.665711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.056103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16180"}
{"level":"info","ts":"2026-05-25T10:21:56.665844Z","caller":"traceutil/trace.go:171","msg":"trace[1734415990] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4874; }","duration":"106.208037ms","start":"2026-05-25T10:21:56.559613Z","end":"2026-05-25T10:21:56.665821Z","steps":["trace[1734415990] 'agreement among raft nodes before linearized reading'  (duration: 105.939151ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:21:56.667427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.087014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ca08699f-7b12-4e0d-862e-8a619c65000b\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-05-25T10:21:56.667515Z","caller":"traceutil/trace.go:171","msg":"trace[1882701262] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ca08699f-7b12-4e0d-862e-8a619c65000b; range_end:; response_count:1; response_revision:4874; }","duration":"107.172956ms","start":"2026-05-25T10:21:56.56031Z","end":"2026-05-25T10:21:56.667482Z","steps":["trace[1882701262] 'agreement among raft nodes before linearized reading'  (duration: 105.734489ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:22:00.305774Z","caller":"traceutil/trace.go:171","msg":"trace[1866539940] linearizableReadLoop","detail":"{readStateIndex:5209; appliedIndex:5208; }","duration":"127.361133ms","start":"2026-05-25T10:22:00.178383Z","end":"2026-05-25T10:22:00.305744Z","steps":["trace[1866539940] 'read index received'  (duration: 75.395047ms)","trace[1866539940] 'applied index is now lower than readState.Index'  (duration: 51.964926ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:22:00.305847Z","caller":"traceutil/trace.go:171","msg":"trace[1060437442] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"204.556223ms","start":"2026-05-25T10:22:00.101228Z","end":"2026-05-25T10:22:00.305784Z","steps":["trace[1060437442] 'process raft request'  (duration: 152.658538ms)","trace[1060437442] 'compare'  (duration: 51.745112ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:22:00.306063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.658048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0129a549-8aed-4aa9-b4d9-adb17c3ea819\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-25T10:22:00.30611Z","caller":"traceutil/trace.go:171","msg":"trace[841247846] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0129a549-8aed-4aa9-b4d9-adb17c3ea819; range_end:; response_count:1; response_revision:5014; }","duration":"127.765241ms","start":"2026-05-25T10:22:00.178333Z","end":"2026-05-25T10:22:00.306098Z","steps":["trace[841247846] 'agreement among raft nodes before linearized reading'  (duration: 127.591418ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:22:00.306168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.441439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gkl25.18b2c7d43e3cb342\" ","response":"range_response_count:1 size:962"}
{"level":"info","ts":"2026-05-25T10:22:00.306226Z","caller":"traceutil/trace.go:171","msg":"trace[1772176880] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gkl25.18b2c7d43e3cb342; range_end:; response_count:1; response_revision:5014; }","duration":"122.527761ms","start":"2026-05-25T10:22:00.183684Z","end":"2026-05-25T10:22:00.306212Z","steps":["trace[1772176880] 'agreement among raft nodes before linearized reading'  (duration: 122.356517ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:22:13.403228Z","caller":"traceutil/trace.go:171","msg":"trace[1903374619] linearizableReadLoop","detail":"{readStateIndex:5473; appliedIndex:5472; }","duration":"119.851149ms","start":"2026-05-25T10:22:13.283345Z","end":"2026-05-25T10:22:13.403196Z","steps":["trace[1903374619] 'read index received'  (duration: 119.492901ms)","trace[1903374619] 'applied index is now lower than readState.Index'  (duration: 357.428µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:22:13.40327Z","caller":"traceutil/trace.go:171","msg":"trace[345963134] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"139.923413ms","start":"2026-05-25T10:22:13.263308Z","end":"2026-05-25T10:22:13.403232Z","steps":["trace[345963134] 'process raft request'  (duration: 139.672468ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:22:13.403476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.099343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T10:22:13.403547Z","caller":"traceutil/trace.go:171","msg":"trace[2016624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5270; }","duration":"120.218216ms","start":"2026-05-25T10:22:13.283312Z","end":"2026-05-25T10:22:13.40353Z","steps":["trace[2016624] 'agreement among raft nodes before linearized reading'  (duration: 120.037153ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:22:13.926751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.006516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.212\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-25T10:22:13.926807Z","caller":"traceutil/trace.go:171","msg":"trace[231207972] range","detail":"{range_begin:/registry/masterleases/199.19.213.212; range_end:; response_count:1; response_revision:5282; }","duration":"177.099427ms","start":"2026-05-25T10:22:13.749695Z","end":"2026-05-25T10:22:13.926794Z","steps":["trace[231207972] 'range keys from in-memory index tree'  (duration: 176.823093ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:22:21.617006Z","caller":"traceutil/trace.go:171","msg":"trace[1219114071] linearizableReadLoop","detail":"{readStateIndex:5646; appliedIndex:5645; }","duration":"127.75928ms","start":"2026-05-25T10:22:21.489229Z","end":"2026-05-25T10:22:21.616989Z","steps":["trace[1219114071] 'read index received'  (duration: 127.606817ms)","trace[1219114071] 'applied index is now lower than readState.Index'  (duration: 151.743µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:22:21.617328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.539147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s2q5b\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-25T10:22:21.617365Z","caller":"traceutil/trace.go:171","msg":"trace[1691729474] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s2q5b; range_end:; response_count:1; response_revision:5438; }","duration":"126.602328ms","start":"2026-05-25T10:22:21.490751Z","end":"2026-05-25T10:22:21.617354Z","steps":["trace[1691729474] 'agreement among raft nodes before linearized reading'  (duration: 126.490496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:22:21.617402Z","caller":"traceutil/trace.go:171","msg":"trace[791967103] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"194.857147ms","start":"2026-05-25T10:22:21.422512Z","end":"2026-05-25T10:22:21.617369Z","steps":["trace[791967103] 'process raft request'  (duration: 194.369278ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:22:21.617502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.238099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-05-25T10:22:21.617594Z","caller":"traceutil/trace.go:171","msg":"trace[240221401] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5438; }","duration":"128.396433ms","start":"2026-05-25T10:22:21.489177Z","end":"2026-05-25T10:22:21.617574Z","steps":["trace[240221401] 'agreement among raft nodes before linearized reading'  (duration: 128.025875ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:23:30.660561Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2986}
{"level":"info","ts":"2026-05-25T10:23:30.728214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2986,"took":"65.982634ms","hash":2269504196,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":34058240,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-25T10:23:30.72829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2269504196,"revision":2986,"compact-revision":-1}
{"level":"info","ts":"2026-05-25T10:25:09.258634Z","caller":"traceutil/trace.go:171","msg":"trace[454978547] transaction","detail":"{read_only:false; response_revision:6682; number_of_response:1; }","duration":"130.741232ms","start":"2026-05-25T10:25:09.127867Z","end":"2026-05-25T10:25:09.258609Z","steps":["trace[454978547] 'process raft request'  (duration: 86.395999ms)","trace[454978547] 'compare'  (duration: 44.264401ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:25:09.889381Z","caller":"traceutil/trace.go:171","msg":"trace[230266883] transaction","detail":"{read_only:false; response_revision:6687; number_of_response:1; }","duration":"102.594317ms","start":"2026-05-25T10:25:09.786753Z","end":"2026-05-25T10:25:09.889347Z","steps":["trace[230266883] 'process raft request'  (duration: 102.440034ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:13.983035Z","caller":"traceutil/trace.go:171","msg":"trace[654257214] transaction","detail":"{read_only:false; response_revision:8194; number_of_response:1; }","duration":"154.271469ms","start":"2026-05-25T10:28:13.828723Z","end":"2026-05-25T10:28:13.982995Z","steps":["trace[654257214] 'process raft request'  (duration: 153.024526ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:13.983051Z","caller":"traceutil/trace.go:171","msg":"trace[2094378105] transaction","detail":"{read_only:false; response_revision:8195; number_of_response:1; }","duration":"120.156556ms","start":"2026-05-25T10:28:13.862862Z","end":"2026-05-25T10:28:13.983019Z","steps":["trace[2094378105] 'process raft request'  (duration: 120.065414ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:25.233407Z","caller":"traceutil/trace.go:171","msg":"trace[945306613] transaction","detail":"{read_only:false; response_revision:8257; number_of_response:1; }","duration":"206.479974ms","start":"2026-05-25T10:28:25.026894Z","end":"2026-05-25T10:28:25.233374Z","steps":["trace[945306613] 'process raft request'  (duration: 206.247419ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:26.225028Z","caller":"traceutil/trace.go:171","msg":"trace[1868697214] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"205.378614ms","start":"2026-05-25T10:28:26.019609Z","end":"2026-05-25T10:28:26.224988Z","steps":["trace[1868697214] 'process raft request'  (duration: 205.21713ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:26.25131Z","caller":"traceutil/trace.go:171","msg":"trace[2020543758] linearizableReadLoop","detail":"{readStateIndex:8554; appliedIndex:8553; }","duration":"160.962516ms","start":"2026-05-25T10:28:26.090321Z","end":"2026-05-25T10:28:26.251283Z","steps":["trace[2020543758] 'read index received'  (duration: 134.654721ms)","trace[2020543758] 'applied index is now lower than readState.Index'  (duration: 26.306895ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:28:26.251351Z","caller":"traceutil/trace.go:171","msg":"trace[2019907175] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"208.601494ms","start":"2026-05-25T10:28:26.042716Z","end":"2026-05-25T10:28:26.251318Z","steps":["trace[2019907175] 'process raft request'  (duration: 208.36743ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:28:26.251587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.234609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-25T10:28:26.251627Z","caller":"traceutil/trace.go:171","msg":"trace[1786469296] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8260; }","duration":"111.36ms","start":"2026-05-25T10:28:26.140253Z","end":"2026-05-25T10:28:26.251613Z","steps":["trace[1786469296] 'agreement among raft nodes before linearized reading'  (duration: 111.173256ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:28:26.251621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.145804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-05-25T10:28:26.251632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.818979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-25T10:28:26.25168Z","caller":"traceutil/trace.go:171","msg":"trace[1094125304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8260; }","duration":"105.245265ms","start":"2026-05-25T10:28:26.146419Z","end":"2026-05-25T10:28:26.251665Z","steps":["trace[1094125304] 'agreement among raft nodes before linearized reading'  (duration: 105.067982ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:26.251709Z","caller":"traceutil/trace.go:171","msg":"trace[434629380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8260; }","duration":"102.947152ms","start":"2026-05-25T10:28:26.148741Z","end":"2026-05-25T10:28:26.251688Z","steps":["trace[434629380] 'agreement among raft nodes before linearized reading'  (duration: 102.752268ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:28:26.251899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.581678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-25T10:28:26.251941Z","caller":"traceutil/trace.go:171","msg":"trace[1178843582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8260; }","duration":"161.67685ms","start":"2026-05-25T10:28:26.090252Z","end":"2026-05-25T10:28:26.251929Z","steps":["trace[1178843582] 'agreement among raft nodes before linearized reading'  (duration: 161.15811ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:26.557459Z","caller":"traceutil/trace.go:171","msg":"trace[471501269] transaction","detail":"{read_only:false; response_revision:8266; number_of_response:1; }","duration":"124.990117ms","start":"2026-05-25T10:28:26.432414Z","end":"2026-05-25T10:28:26.557405Z","steps":["trace[471501269] 'process raft request'  (duration: 42.663984ms)","trace[471501269] 'compare'  (duration: 82.112889ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:28:26.557608Z","caller":"traceutil/trace.go:171","msg":"trace[175649998] transaction","detail":"{read_only:false; response_revision:8267; number_of_response:1; }","duration":"125.141069ms","start":"2026-05-25T10:28:26.432439Z","end":"2026-05-25T10:28:26.55758Z","steps":["trace[175649998] 'process raft request'  (duration: 124.889485ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:30.667238Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6091}
{"level":"info","ts":"2026-05-25T10:28:30.764622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6091,"took":"95.219836ms","hash":1239922,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":23363584,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-25T10:28:30.765384Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1239922,"revision":6091,"compact-revision":2986}
{"level":"warn","ts":"2026-05-25T10:28:54.220516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.83904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T10:28:54.220606Z","caller":"traceutil/trace.go:171","msg":"trace[1128569980] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:8464; }","duration":"189.938282ms","start":"2026-05-25T10:28:54.030646Z","end":"2026-05-25T10:28:54.220585Z","steps":["trace[1128569980] 'count revisions from in-memory index tree'  (duration: 189.758908ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:28:54.221176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.193506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s2q5b\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-25T10:28:54.221295Z","caller":"traceutil/trace.go:171","msg":"trace[1054534449] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s2q5b; range_end:; response_count:1; response_revision:8464; }","duration":"305.357969ms","start":"2026-05-25T10:28:53.915907Z","end":"2026-05-25T10:28:54.221265Z","steps":["trace[1054534449] 'range keys from in-memory index tree'  (duration: 304.979352ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:28:54.221363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:28:53.915877Z","time spent":"305.471461ms","remote":"127.0.0.1:32908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-s2q5b\" "}
{"level":"info","ts":"2026-05-25T10:28:56.795124Z","caller":"traceutil/trace.go:171","msg":"trace[1300662910] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"126.152239ms","start":"2026-05-25T10:28:56.668943Z","end":"2026-05-25T10:28:56.795095Z","steps":["trace[1300662910] 'process raft request'  (duration: 125.980186ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:28:56.96472Z","caller":"traceutil/trace.go:171","msg":"trace[1447297653] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"247.252933ms","start":"2026-05-25T10:28:56.717435Z","end":"2026-05-25T10:28:56.964688Z","steps":["trace[1447297653] 'process raft request'  (duration: 225.273459ms)","trace[1447297653] 'compare'  (duration: 21.872402ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:29:06.569314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.449805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-25T10:29:06.570312Z","caller":"traceutil/trace.go:171","msg":"trace[1881177291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8574; }","duration":"101.481394ms","start":"2026-05-25T10:29:06.468777Z","end":"2026-05-25T10:29:06.570258Z","steps":["trace[1881177291] 'range keys from in-memory index tree'  (duration: 100.315952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.687779Z","caller":"traceutil/trace.go:171","msg":"trace[1142138979] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"114.007271ms","start":"2026-05-25T10:29:06.573737Z","end":"2026-05-25T10:29:06.687744Z","steps":["trace[1142138979] 'process raft request'  (duration: 113.777197ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.688017Z","caller":"traceutil/trace.go:171","msg":"trace[2015772790] transaction","detail":"{read_only:false; response_revision:8576; number_of_response:1; }","duration":"114.235035ms","start":"2026-05-25T10:29:06.573748Z","end":"2026-05-25T10:29:06.687983Z","steps":["trace[2015772790] 'process raft request'  (duration: 113.94523ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.8172Z","caller":"traceutil/trace.go:171","msg":"trace[1232319926] linearizableReadLoop","detail":"{readStateIndex:8888; appliedIndex:8884; }","duration":"234.586984ms","start":"2026-05-25T10:29:06.582586Z","end":"2026-05-25T10:29:06.817173Z","steps":["trace[1232319926] 'read index received'  (duration: 104.911509ms)","trace[1232319926] 'applied index is now lower than readState.Index'  (duration: 129.674285ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:29:06.817323Z","caller":"traceutil/trace.go:171","msg":"trace[1132857011] transaction","detail":"{read_only:false; response_revision:8577; number_of_response:1; }","duration":"243.268857ms","start":"2026-05-25T10:29:06.574042Z","end":"2026-05-25T10:29:06.817311Z","steps":["trace[1132857011] 'process raft request'  (duration: 242.941431ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.817359Z","caller":"traceutil/trace.go:171","msg":"trace[1228472562] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"242.678007ms","start":"2026-05-25T10:29:06.574666Z","end":"2026-05-25T10:29:06.817344Z","steps":["trace[1228472562] 'process raft request'  (duration: 242.451313ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:29:06.817599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.001702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-25T10:29:06.817631Z","caller":"traceutil/trace.go:171","msg":"trace[1471272264] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8578; }","duration":"235.072264ms","start":"2026-05-25T10:29:06.582552Z","end":"2026-05-25T10:29:06.817624Z","steps":["trace[1471272264] 'agreement among raft nodes before linearized reading'  (duration: 234.90593ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.923952Z","caller":"traceutil/trace.go:171","msg":"trace[1873568485] linearizableReadLoop","detail":"{readStateIndex:8890; appliedIndex:8888; }","duration":"106.645611ms","start":"2026-05-25T10:29:06.817275Z","end":"2026-05-25T10:29:06.923921Z","steps":["trace[1873568485] 'read index received'  (duration: 99.544567ms)","trace[1873568485] 'applied index is now lower than readState.Index'  (duration: 7.099634ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:29:06.924022Z","caller":"traceutil/trace.go:171","msg":"trace[1034405453] transaction","detail":"{read_only:false; response_revision:8580; number_of_response:1; }","duration":"133.190583ms","start":"2026-05-25T10:29:06.790797Z","end":"2026-05-25T10:29:06.923988Z","steps":["trace[1034405453] 'process raft request'  (duration: 133.021959ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.924058Z","caller":"traceutil/trace.go:171","msg":"trace[1223068221] transaction","detail":"{read_only:false; response_revision:8579; number_of_response:1; }","duration":"141.155652ms","start":"2026-05-25T10:29:06.782766Z","end":"2026-05-25T10:29:06.923921Z","steps":["trace[1223068221] 'process raft request'  (duration: 134.040928ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:29:06.924223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.179052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-ptr2q\" ","response":"range_response_count:1 size:4650"}
{"level":"info","ts":"2026-05-25T10:29:06.924272Z","caller":"traceutil/trace.go:171","msg":"trace[185607619] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-ptr2q; range_end:; response_count:1; response_revision:8580; }","duration":"142.301904ms","start":"2026-05-25T10:29:06.781959Z","end":"2026-05-25T10:29:06.92426Z","steps":["trace[185607619] 'agreement among raft nodes before linearized reading'  (duration: 142.08372ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.934769Z","caller":"traceutil/trace.go:171","msg":"trace[1326991711] transaction","detail":"{read_only:false; response_revision:8581; number_of_response:1; }","duration":"113.263926ms","start":"2026-05-25T10:29:06.821485Z","end":"2026-05-25T10:29:06.934749Z","steps":["trace[1326991711] 'process raft request'  (duration: 113.097303ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:06.93497Z","caller":"traceutil/trace.go:171","msg":"trace[1169359916] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"109.848632ms","start":"2026-05-25T10:29:06.825098Z","end":"2026-05-25T10:29:06.934947Z","steps":["trace[1169359916] 'process raft request'  (duration: 109.605657ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:29:24.722401Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000239f.wal"}
{"level":"info","ts":"2026-05-25T10:30:06.733184Z","caller":"traceutil/trace.go:171","msg":"trace[1949870252] transaction","detail":"{read_only:false; response_revision:9178; number_of_response:1; }","duration":"125.274183ms","start":"2026-05-25T10:30:06.607884Z","end":"2026-05-25T10:30:06.733158Z","steps":["trace[1949870252] 'process raft request'  (duration: 105.160354ms)","trace[1949870252] 'compare'  (duration: 19.767912ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:30:08.457074Z","caller":"traceutil/trace.go:171","msg":"trace[744017855] transaction","detail":"{read_only:false; response_revision:9221; number_of_response:1; }","duration":"126.910974ms","start":"2026-05-25T10:30:08.33013Z","end":"2026-05-25T10:30:08.457041Z","steps":["trace[744017855] 'process raft request'  (duration: 126.576497ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:30:08.579675Z","caller":"traceutil/trace.go:171","msg":"trace[875661791] linearizableReadLoop","detail":"{readStateIndex:9549; appliedIndex:9547; }","duration":"215.868001ms","start":"2026-05-25T10:30:08.363785Z","end":"2026-05-25T10:30:08.579653Z","steps":["trace[875661791] 'read index received'  (duration: 92.859781ms)","trace[875661791] 'applied index is now lower than readState.Index'  (duration: 123.0074ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:30:08.579726Z","caller":"traceutil/trace.go:171","msg":"trace[688647435] transaction","detail":"{read_only:false; response_revision:9222; number_of_response:1; }","duration":"243.401511ms","start":"2026-05-25T10:30:08.336304Z","end":"2026-05-25T10:30:08.579706Z","steps":["trace[688647435] 'process raft request'  (duration: 235.990772ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:30:08.579803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.004964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-25T10:30:08.579827Z","caller":"traceutil/trace.go:171","msg":"trace[497636718] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9222; }","duration":"216.077525ms","start":"2026-05-25T10:30:08.363743Z","end":"2026-05-25T10:30:08.57982Z","steps":["trace[497636718] 'agreement among raft nodes before linearized reading'  (duration: 216.011014ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:30:08.593869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.777292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-05-25T10:30:08.59391Z","caller":"traceutil/trace.go:171","msg":"trace[634947586] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:9223; }","duration":"116.864304ms","start":"2026-05-25T10:30:08.477037Z","end":"2026-05-25T10:30:08.593901Z","steps":["trace[634947586] 'agreement among raft nodes before linearized reading'  (duration: 116.66805ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:30:09.618247Z","caller":"traceutil/trace.go:171","msg":"trace[1740021438] transaction","detail":"{read_only:false; response_revision:9247; number_of_response:1; }","duration":"131.145614ms","start":"2026-05-25T10:30:09.487081Z","end":"2026-05-25T10:30:09.618226Z","steps":["trace[1740021438] 'process raft request'  (duration: 131.065953ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:30:09.618288Z","caller":"traceutil/trace.go:171","msg":"trace[2146505207] transaction","detail":"{read_only:false; response_revision:9246; number_of_response:1; }","duration":"137.422171ms","start":"2026-05-25T10:30:09.480825Z","end":"2026-05-25T10:30:09.618247Z","steps":["trace[2146505207] 'process raft request'  (duration: 51.420899ms)","trace[2146505207] 'compare'  (duration: 85.628916ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:31:07.489942Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1ab0380b9290bdc","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T10:31:07.496912Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-25T10:31:07.497028Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-25T10:32:36.012621Z","caller":"traceutil/trace.go:171","msg":"trace[1320939216] transaction","detail":"{read_only:false; response_revision:10359; number_of_response:1; }","duration":"119.852515ms","start":"2026-05-25T10:32:35.892745Z","end":"2026-05-25T10:32:36.012598Z","steps":["trace[1320939216] 'process raft request'  (duration: 119.670301ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:32:36.012892Z","caller":"traceutil/trace.go:171","msg":"trace[1505678268] transaction","detail":"{read_only:false; response_revision:10360; number_of_response:1; }","duration":"118.465949ms","start":"2026-05-25T10:32:35.894386Z","end":"2026-05-25T10:32:36.012852Z","steps":["trace[1505678268] 'process raft request'  (duration: 118.162213ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:33:30.674132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8295}
{"level":"info","ts":"2026-05-25T10:33:30.754555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8295,"took":"77.970224ms","hash":3820881891,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":26583040,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-25T10:33:30.754657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3820881891,"revision":8295,"compact-revision":6091}
{"level":"info","ts":"2026-05-25T10:33:58.344855Z","caller":"traceutil/trace.go:171","msg":"trace[789278723] linearizableReadLoop","detail":"{readStateIndex:11519; appliedIndex:11518; }","duration":"183.553469ms","start":"2026-05-25T10:33:58.161267Z","end":"2026-05-25T10:33:58.34482Z","steps":["trace[789278723] 'read index received'  (duration: 183.220913ms)","trace[789278723] 'applied index is now lower than readState.Index'  (duration: 330.756µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:33:58.344897Z","caller":"traceutil/trace.go:171","msg":"trace[321424800] transaction","detail":"{read_only:false; response_revision:11136; number_of_response:1; }","duration":"188.411661ms","start":"2026-05-25T10:33:58.156457Z","end":"2026-05-25T10:33:58.344869Z","steps":["trace[321424800] 'process raft request'  (duration: 188.153765ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:33:58.345188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.976634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-25T10:33:58.345274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.284954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-25T10:33:58.345306Z","caller":"traceutil/trace.go:171","msg":"trace[322496575] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:11136; }","duration":"169.112387ms","start":"2026-05-25T10:33:58.176165Z","end":"2026-05-25T10:33:58.345277Z","steps":["trace[322496575] 'agreement among raft nodes before linearized reading'  (duration: 168.892993ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:33:58.345386Z","caller":"traceutil/trace.go:171","msg":"trace[306959655] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11136; }","duration":"129.468627ms","start":"2026-05-25T10:33:58.215891Z","end":"2026-05-25T10:33:58.34536Z","steps":["trace[306959655] 'agreement among raft nodes before linearized reading'  (duration: 129.230103ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:33:58.345715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.420136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-25T10:33:58.345876Z","caller":"traceutil/trace.go:171","msg":"trace[1453785023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11136; }","duration":"184.587368ms","start":"2026-05-25T10:33:58.161236Z","end":"2026-05-25T10:33:58.345823Z","steps":["trace[1453785023] 'agreement among raft nodes before linearized reading'  (duration: 183.748773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:38:30.680584Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10962}
{"level":"info","ts":"2026-05-25T10:38:30.759307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10962,"took":"75.313617ms","hash":2555171759,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":28143616,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-25T10:38:30.759409Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2555171759,"revision":10962,"compact-revision":8295}
{"level":"info","ts":"2026-05-25T10:40:19.518738Z","caller":"traceutil/trace.go:171","msg":"trace[284073847] linearizableReadLoop","detail":"{readStateIndex:14178; appliedIndex:14177; }","duration":"234.818859ms","start":"2026-05-25T10:40:19.283893Z","end":"2026-05-25T10:40:19.518712Z","steps":["trace[284073847] 'read index received'  (duration: 234.742838ms)","trace[284073847] 'applied index is now lower than readState.Index'  (duration: 74.511µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:40:19.518861Z","caller":"traceutil/trace.go:171","msg":"trace[162220788] transaction","detail":"{read_only:false; response_revision:13704; number_of_response:1; }","duration":"249.68622ms","start":"2026-05-25T10:40:19.269162Z","end":"2026-05-25T10:40:19.518848Z","steps":["trace[162220788] 'process raft request'  (duration: 249.372905ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:40:19.519043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.125424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T10:40:19.519091Z","caller":"traceutil/trace.go:171","msg":"trace[883583893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13704; }","duration":"235.253387ms","start":"2026-05-25T10:40:19.283829Z","end":"2026-05-25T10:40:19.519082Z","steps":["trace[883583893] 'agreement among raft nodes before linearized reading'  (duration: 235.155045ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:40:19.632229Z","caller":"traceutil/trace.go:171","msg":"trace[990666442] linearizableReadLoop","detail":"{readStateIndex:14179; appliedIndex:14178; }","duration":"113.378488ms","start":"2026-05-25T10:40:19.518815Z","end":"2026-05-25T10:40:19.632194Z","steps":["trace[990666442] 'read index received'  (duration: 107.322902ms)","trace[990666442] 'applied index is now lower than readState.Index'  (duration: 6.053896ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:40:19.632334Z","caller":"traceutil/trace.go:171","msg":"trace[751813077] transaction","detail":"{read_only:false; response_revision:13705; number_of_response:1; }","duration":"227.597863ms","start":"2026-05-25T10:40:19.404694Z","end":"2026-05-25T10:40:19.632292Z","steps":["trace[751813077] 'process raft request'  (duration: 221.548027ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:40:19.632562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.692838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s2q5b\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-05-25T10:40:19.632612Z","caller":"traceutil/trace.go:171","msg":"trace[311898814] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s2q5b; range_end:; response_count:1; response_revision:13705; }","duration":"299.799089ms","start":"2026-05-25T10:40:19.3328Z","end":"2026-05-25T10:40:19.632599Z","steps":["trace[311898814] 'agreement among raft nodes before linearized reading'  (duration: 299.584125ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:40:19.632755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.718075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-25T10:40:19.63288Z","caller":"traceutil/trace.go:171","msg":"trace[1224199067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13705; }","duration":"112.906479ms","start":"2026-05-25T10:40:19.519942Z","end":"2026-05-25T10:40:19.632849Z","steps":["trace[1224199067] 'agreement among raft nodes before linearized reading'  (duration: 112.620294ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:40:41.885727Z","caller":"traceutil/trace.go:171","msg":"trace[425727161] transaction","detail":"{read_only:false; response_revision:14018; number_of_response:1; }","duration":"325.338523ms","start":"2026-05-25T10:40:41.560359Z","end":"2026-05-25T10:40:41.885698Z","steps":["trace[425727161] 'process raft request'  (duration: 325.166219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:40:41.886387Z","caller":"traceutil/trace.go:171","msg":"trace[50387301] linearizableReadLoop","detail":"{readStateIndex:14505; appliedIndex:14503; }","duration":"299.889721ms","start":"2026-05-25T10:40:41.586467Z","end":"2026-05-25T10:40:41.886357Z","steps":["trace[50387301] 'read index received'  (duration: 299.114206ms)","trace[50387301] 'applied index is now lower than readState.Index'  (duration: 773.975µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:40:41.886398Z","caller":"traceutil/trace.go:171","msg":"trace[143342180] transaction","detail":"{read_only:false; response_revision:14019; number_of_response:1; }","duration":"314.345475ms","start":"2026-05-25T10:40:41.572028Z","end":"2026-05-25T10:40:41.886373Z","steps":["trace[143342180] 'process raft request'  (duration: 314.196692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:40:41.886454Z","caller":"traceutil/trace.go:171","msg":"trace[537788675] transaction","detail":"{read_only:false; response_revision:14020; number_of_response:1; }","duration":"172.168002ms","start":"2026-05-25T10:40:41.714275Z","end":"2026-05-25T10:40:41.886443Z","steps":["trace[537788675] 'process raft request'  (duration: 172.03531ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:40:41.886494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:41.57201Z","time spent":"314.441547ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:13835 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-25T10:40:41.886516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.053214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e5f00a12-ce6a-4596-8ce8-eecef607af30\" ","response":"range_response_count:1 size:3757"}
{"level":"info","ts":"2026-05-25T10:40:41.886566Z","caller":"traceutil/trace.go:171","msg":"trace[1193393479] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e5f00a12-ce6a-4596-8ce8-eecef607af30; range_end:; response_count:1; response_revision:14020; }","duration":"300.146526ms","start":"2026-05-25T10:40:41.586394Z","end":"2026-05-25T10:40:41.886541Z","steps":["trace[1193393479] 'agreement among raft nodes before linearized reading'  (duration: 300.074865ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:40:41.886597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:41.586365Z","time spent":"300.224008ms","remote":"127.0.0.1:32908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3781,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e5f00a12-ce6a-4596-8ce8-eecef607af30\" "}
{"level":"warn","ts":"2026-05-25T10:40:41.886389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:41.560339Z","time spent":"325.552788ms","remote":"127.0.0.1:32908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e5f00a12-ce6a-4596-8ce8-eecef607af30\" mod_revision:14000 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e5f00a12-ce6a-4596-8ce8-eecef607af30\" value_size:3642 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e5f00a12-ce6a-4596-8ce8-eecef607af30\" > >"}
{"level":"info","ts":"2026-05-25T10:42:07.476848Z","caller":"traceutil/trace.go:171","msg":"trace[1085161979] transaction","detail":"{read_only:false; response_revision:14827; number_of_response:1; }","duration":"130.424235ms","start":"2026-05-25T10:42:07.346378Z","end":"2026-05-25T10:42:07.476802Z","steps":["trace[1085161979] 'process raft request'  (duration: 130.026558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:43:30.686053Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12998}
{"level":"info","ts":"2026-05-25T10:43:30.762211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12998,"took":"73.323645ms","hash":4272128281,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":30478336,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-25T10:43:30.762313Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4272128281,"revision":12998,"compact-revision":10962}
{"level":"warn","ts":"2026-05-25T10:47:34.820391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.025168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-25T10:47:34.820478Z","caller":"traceutil/trace.go:171","msg":"trace[1723987641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17300; }","duration":"146.120859ms","start":"2026-05-25T10:47:34.67434Z","end":"2026-05-25T10:47:34.820461Z","steps":["trace[1723987641] 'range keys from in-memory index tree'  (duration: 145.845954ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:47:34.820686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.971019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-25T10:47:34.820763Z","caller":"traceutil/trace.go:171","msg":"trace[436876409] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17300; }","duration":"144.093691ms","start":"2026-05-25T10:47:34.676651Z","end":"2026-05-25T10:47:34.820745Z","steps":["trace[436876409] 'range keys from in-memory index tree'  (duration: 143.799676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:47:34.820786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.500576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-l969z\" ","response":"range_response_count:1 size:9800"}
{"level":"info","ts":"2026-05-25T10:47:34.820861Z","caller":"traceutil/trace.go:171","msg":"trace[697106786] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-l969z; range_end:; response_count:1; response_revision:17300; }","duration":"165.585297ms","start":"2026-05-25T10:47:34.655262Z","end":"2026-05-25T10:47:34.820847Z","steps":["trace[697106786] 'range keys from in-memory index tree'  (duration: 165.287642ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:47:40.83157Z","caller":"traceutil/trace.go:171","msg":"trace[1092380270] transaction","detail":"{read_only:false; response_revision:17336; number_of_response:1; }","duration":"191.697451ms","start":"2026-05-25T10:47:40.639851Z","end":"2026-05-25T10:47:40.831548Z","steps":["trace[1092380270] 'process raft request'  (duration: 191.599799ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:47:40.838807Z","caller":"traceutil/trace.go:171","msg":"trace[1424349361] linearizableReadLoop","detail":"{readStateIndex:17930; appliedIndex:17927; }","duration":"103.842851ms","start":"2026-05-25T10:47:40.734953Z","end":"2026-05-25T10:47:40.838796Z","steps":["trace[1424349361] 'read index received'  (duration: 96.503862ms)","trace[1424349361] 'applied index is now lower than readState.Index'  (duration: 7.337689ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:47:40.838958Z","caller":"traceutil/trace.go:171","msg":"trace[1602818802] transaction","detail":"{read_only:false; response_revision:17337; number_of_response:1; }","duration":"198.57933ms","start":"2026-05-25T10:47:40.640371Z","end":"2026-05-25T10:47:40.83895Z","steps":["trace[1602818802] 'process raft request'  (duration: 198.336785ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:47:40.839054Z","caller":"traceutil/trace.go:171","msg":"trace[138949104] transaction","detail":"{read_only:false; response_revision:17338; number_of_response:1; }","duration":"121.304711ms","start":"2026-05-25T10:47:40.717744Z","end":"2026-05-25T10:47:40.839048Z","steps":["trace[138949104] 'process raft request'  (duration: 121.019645ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:47:40.839167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.206509ms","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-05-25T10:47:40.8392Z","caller":"traceutil/trace.go:171","msg":"trace[1664345553] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:17338; }","duration":"104.301741ms","start":"2026-05-25T10:47:40.734888Z","end":"2026-05-25T10:47:40.83919Z","steps":["trace[1664345553] 'agreement among raft nodes before linearized reading'  (duration: 104.23633ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:48:30.693929Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15382}
{"level":"info","ts":"2026-05-25T10:48:30.793206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15382,"took":"96.686086ms","hash":3802490299,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":33255424,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-25T10:48:30.793278Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3802490299,"revision":15382,"compact-revision":12998}
{"level":"info","ts":"2026-05-25T10:51:40.126356Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1ab0380b9290bdc","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T10:51:40.133991Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-25T10:51:40.134121Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-25T10:53:07.754732Z","caller":"traceutil/trace.go:171","msg":"trace[109558719] transaction","detail":"{read_only:false; response_revision:19912; number_of_response:1; }","duration":"119.638528ms","start":"2026-05-25T10:53:07.635066Z","end":"2026-05-25T10:53:07.754705Z","steps":["trace[109558719] 'process raft request'  (duration: 119.470195ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:53:08.238842Z","caller":"traceutil/trace.go:171","msg":"trace[674538510] transaction","detail":"{read_only:false; response_revision:19913; number_of_response:1; }","duration":"216.135881ms","start":"2026-05-25T10:53:08.02267Z","end":"2026-05-25T10:53:08.238806Z","steps":["trace[674538510] 'process raft request'  (duration: 215.949857ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:53:08.238929Z","caller":"traceutil/trace.go:171","msg":"trace[1022656145] linearizableReadLoop","detail":"{readStateIndex:20588; appliedIndex:20588; }","duration":"117.58207ms","start":"2026-05-25T10:53:08.121321Z","end":"2026-05-25T10:53:08.238903Z","steps":["trace[1022656145] 'read index received'  (duration: 117.57206ms)","trace[1022656145] 'applied index is now lower than readState.Index'  (duration: 7.57µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:53:08.239221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.875805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-25T10:53:08.23935Z","caller":"traceutil/trace.go:171","msg":"trace[1003484674] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:19913; }","duration":"118.0662ms","start":"2026-05-25T10:53:08.121259Z","end":"2026-05-25T10:53:08.239326Z","steps":["trace[1003484674] 'agreement among raft nodes before linearized reading'  (duration: 117.850745ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:53:08.971449Z","caller":"traceutil/trace.go:171","msg":"trace[226261552] transaction","detail":"{read_only:false; response_revision:19919; number_of_response:1; }","duration":"248.311918ms","start":"2026-05-25T10:53:08.723083Z","end":"2026-05-25T10:53:08.971395Z","steps":["trace[226261552] 'process raft request'  (duration: 248.103124ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:53:08.994287Z","caller":"traceutil/trace.go:171","msg":"trace[147626942] transaction","detail":"{read_only:false; response_revision:19920; number_of_response:1; }","duration":"261.61406ms","start":"2026-05-25T10:53:08.732631Z","end":"2026-05-25T10:53:08.994245Z","steps":["trace[147626942] 'process raft request'  (duration: 261.380236ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:53:09.112237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.975468ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543469700 > lease_revoke:<id:0bdc9e5ea0161ba1>","response":"size:30"}
{"level":"info","ts":"2026-05-25T10:53:09.112336Z","caller":"traceutil/trace.go:171","msg":"trace[701131567] linearizableReadLoop","detail":"{readStateIndex:20595; appliedIndex:20593; }","duration":"289.946924ms","start":"2026-05-25T10:53:08.822371Z","end":"2026-05-25T10:53:09.112318Z","steps":["trace[701131567] 'read index received'  (duration: 148.681107ms)","trace[701131567] 'applied index is now lower than readState.Index'  (duration: 141.264687ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:53:09.112464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.096118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T10:53:09.112512Z","caller":"traceutil/trace.go:171","msg":"trace[602754994] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:19920; }","duration":"290.21879ms","start":"2026-05-25T10:53:08.822284Z","end":"2026-05-25T10:53:09.112503Z","steps":["trace[602754994] 'agreement among raft nodes before linearized reading'  (duration: 290.133688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:53:09.11284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.216343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-25T10:53:09.112913Z","caller":"traceutil/trace.go:171","msg":"trace[2048560164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19920; }","duration":"287.340345ms","start":"2026-05-25T10:53:08.825556Z","end":"2026-05-25T10:53:09.112896Z","steps":["trace[2048560164] 'agreement among raft nodes before linearized reading'  (duration: 286.926287ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:53:09.239549Z","caller":"traceutil/trace.go:171","msg":"trace[1702146182] transaction","detail":"{read_only:false; response_revision:19921; number_of_response:1; }","duration":"122.182807ms","start":"2026-05-25T10:53:09.117336Z","end":"2026-05-25T10:53:09.239519Z","steps":["trace[1702146182] 'process raft request'  (duration: 121.991814ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:53:30.70141Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17945}
{"level":"info","ts":"2026-05-25T10:53:30.823832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17945,"took":"118.884735ms","hash":102473609,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":29437952,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-25T10:53:30.823906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":102473609,"revision":17945,"compact-revision":15382}
{"level":"warn","ts":"2026-05-25T10:56:51.397541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.134154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543476686 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:22256 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T10:56:51.39767Z","caller":"traceutil/trace.go:171","msg":"trace[1714240121] linearizableReadLoop","detail":"{readStateIndex:23041; appliedIndex:23040; }","duration":"114.837288ms","start":"2026-05-25T10:56:51.282813Z","end":"2026-05-25T10:56:51.397651Z","steps":["trace[1714240121] 'read index received'  (duration: 47.071µs)","trace[1714240121] 'applied index is now lower than readState.Index'  (duration: 114.788917ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:56:51.397697Z","caller":"traceutil/trace.go:171","msg":"trace[1690537134] transaction","detail":"{read_only:false; response_revision:22295; number_of_response:1; }","duration":"253.771751ms","start":"2026-05-25T10:56:51.14389Z","end":"2026-05-25T10:56:51.397662Z","steps":["trace[1690537134] 'process raft request'  (duration: 13.407953ms)","trace[1690537134] 'compare'  (duration: 240.007951ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:56:51.397768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.961101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T10:56:51.39786Z","caller":"traceutil/trace.go:171","msg":"trace[853379769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22295; }","duration":"115.088042ms","start":"2026-05-25T10:56:51.282759Z","end":"2026-05-25T10:56:51.397847Z","steps":["trace[853379769] 'agreement among raft nodes before linearized reading'  (duration: 114.9717ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:56:51.399356Z","caller":"traceutil/trace.go:171","msg":"trace[651421872] transaction","detail":"{read_only:false; response_revision:22296; number_of_response:1; }","duration":"105.586923ms","start":"2026-05-25T10:56:51.293748Z","end":"2026-05-25T10:56:51.399335Z","steps":["trace[651421872] 'process raft request'  (duration: 105.329969ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:58:30.719426Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20033}
{"level":"info","ts":"2026-05-25T10:58:30.824985Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20033,"took":"101.308862ms","hash":3669549426,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":42041344,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-25T10:58:30.825055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3669549426,"revision":20033,"compact-revision":17945}
{"level":"info","ts":"2026-05-25T10:59:54.91042Z","caller":"traceutil/trace.go:171","msg":"trace[157358099] transaction","detail":"{read_only:false; response_revision:24194; number_of_response:1; }","duration":"116.074702ms","start":"2026-05-25T10:59:54.794317Z","end":"2026-05-25T10:59:54.910392Z","steps":["trace[157358099] 'process raft request'  (duration: 115.881608ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:54.97723Z","caller":"traceutil/trace.go:171","msg":"trace[1094481595] transaction","detail":"{read_only:false; response_revision:24195; number_of_response:1; }","duration":"181.61918ms","start":"2026-05-25T10:59:54.795578Z","end":"2026-05-25T10:59:54.977197Z","steps":["trace[1094481595] 'process raft request'  (duration: 181.380805ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:54.977269Z","caller":"traceutil/trace.go:171","msg":"trace[1244223670] transaction","detail":"{read_only:false; response_revision:24196; number_of_response:1; }","duration":"181.546768ms","start":"2026-05-25T10:59:54.795692Z","end":"2026-05-25T10:59:54.977239Z","steps":["trace[1244223670] 'process raft request'  (duration: 181.429896ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:59:55.225127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.878063ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481227 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24159 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T10:59:55.225276Z","caller":"traceutil/trace.go:171","msg":"trace[815146594] transaction","detail":"{read_only:false; response_revision:24197; number_of_response:1; }","duration":"288.387686ms","start":"2026-05-25T10:59:54.936861Z","end":"2026-05-25T10:59:55.225249Z","steps":["trace[815146594] 'process raft request'  (duration: 149.269199ms)","trace[815146594] 'compare'  (duration: 138.319912ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:59:55.543569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.91177ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481229 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:23970 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T10:59:55.543762Z","caller":"traceutil/trace.go:171","msg":"trace[1236424508] transaction","detail":"{read_only:false; response_revision:24199; number_of_response:1; }","duration":"362.035518ms","start":"2026-05-25T10:59:55.181709Z","end":"2026-05-25T10:59:55.543744Z","steps":["trace[1236424508] 'process raft request'  (duration: 361.972667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:59:55.543834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:59:55.181673Z","time spent":"362.13072ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24184 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-25T10:59:55.544068Z","caller":"traceutil/trace.go:171","msg":"trace[1916484829] linearizableReadLoop","detail":"{readStateIndex:24991; appliedIndex:24989; }","duration":"540.08802ms","start":"2026-05-25T10:59:55.003935Z","end":"2026-05-25T10:59:55.544023Z","steps":["trace[1916484829] 'read index received'  (duration: 82.210802ms)","trace[1916484829] 'applied index is now lower than readState.Index'  (duration: 457.872628ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:59:55.544093Z","caller":"traceutil/trace.go:171","msg":"trace[252275902] transaction","detail":"{read_only:false; response_revision:24198; number_of_response:1; }","duration":"561.27659ms","start":"2026-05-25T10:59:54.982775Z","end":"2026-05-25T10:59:55.544052Z","steps":["trace[252275902] 'process raft request'  (duration: 391.777629ms)","trace[252275902] 'compare'  (duration: 168.791167ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:59:55.54425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:59:54.982757Z","time spent":"561.407722ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:23970 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"warn","ts":"2026-05-25T10:59:55.544293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.344265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-25T10:59:55.544361Z","caller":"traceutil/trace.go:171","msg":"trace[1179558700] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24199; }","duration":"540.442357ms","start":"2026-05-25T10:59:55.003898Z","end":"2026-05-25T10:59:55.54434Z","steps":["trace[1179558700] 'agreement among raft nodes before linearized reading'  (duration: 540.216422ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:59:55.544384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.101024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-25T10:59:55.544362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.688123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T10:59:55.544455Z","caller":"traceutil/trace.go:171","msg":"trace[690305431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24199; }","duration":"339.204396ms","start":"2026-05-25T10:59:55.205217Z","end":"2026-05-25T10:59:55.544421Z","steps":["trace[690305431] 'agreement among raft nodes before linearized reading'  (duration: 338.994832ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:55.544468Z","caller":"traceutil/trace.go:171","msg":"trace[1579814524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24199; }","duration":"260.841246ms","start":"2026-05-25T10:59:55.283601Z","end":"2026-05-25T10:59:55.544443Z","steps":["trace[1579814524] 'agreement among raft nodes before linearized reading'  (duration: 260.654963ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:59:55.544402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:59:55.003884Z","time spent":"540.509487ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-25T10:59:55.544509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:59:55.205192Z","time spent":"339.305567ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-25T10:59:55.814957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.460881ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481234 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24185 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T10:59:55.815136Z","caller":"traceutil/trace.go:171","msg":"trace[1008314774] transaction","detail":"{read_only:false; response_revision:24201; number_of_response:1; }","duration":"258.41598ms","start":"2026-05-25T10:59:55.556703Z","end":"2026-05-25T10:59:55.815119Z","steps":["trace[1008314774] 'process raft request'  (duration: 258.356279ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:55.81533Z","caller":"traceutil/trace.go:171","msg":"trace[230284620] linearizableReadLoop","detail":"{readStateIndex:24993; appliedIndex:24992; }","duration":"265.135837ms","start":"2026-05-25T10:59:55.550169Z","end":"2026-05-25T10:59:55.815305Z","steps":["trace[230284620] 'read index received'  (duration: 123.259637ms)","trace[230284620] 'applied index is now lower than readState.Index'  (duration: 141.87242ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:59:55.815383Z","caller":"traceutil/trace.go:171","msg":"trace[1425263699] transaction","detail":"{read_only:false; response_revision:24200; number_of_response:1; }","duration":"265.691518ms","start":"2026-05-25T10:59:55.549657Z","end":"2026-05-25T10:59:55.815349Z","steps":["trace[1425263699] 'process raft request'  (duration: 123.764167ms)","trace[1425263699] 'compare'  (duration: 141.344359ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:59:55.815617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.452814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-25T10:59:55.815669Z","caller":"traceutil/trace.go:171","msg":"trace[1069118183] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24201; }","duration":"265.545855ms","start":"2026-05-25T10:59:55.550111Z","end":"2026-05-25T10:59:55.815657Z","steps":["trace[1069118183] 'agreement among raft nodes before linearized reading'  (duration: 265.321581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:56.09545Z","caller":"traceutil/trace.go:171","msg":"trace[1538500613] transaction","detail":"{read_only:false; response_revision:24202; number_of_response:1; }","duration":"406.350454ms","start":"2026-05-25T10:59:55.689078Z","end":"2026-05-25T10:59:56.095429Z","steps":["trace[1538500613] 'process raft request'  (duration: 371.418705ms)","trace[1538500613] 'compare'  (duration: 34.776996ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T10:59:56.095582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:59:55.689049Z","time spent":"406.465427ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24186 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-25T10:59:56.095837Z","caller":"traceutil/trace.go:171","msg":"trace[69846167] linearizableReadLoop","detail":"{readStateIndex:24996; appliedIndex:24994; }","duration":"278.53454ms","start":"2026-05-25T10:59:55.817274Z","end":"2026-05-25T10:59:56.095809Z","steps":["trace[69846167] 'read index received'  (duration: 243.240114ms)","trace[69846167] 'applied index is now lower than readState.Index'  (duration: 35.293326ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T10:59:56.095867Z","caller":"traceutil/trace.go:171","msg":"trace[1648453154] transaction","detail":"{read_only:false; response_revision:24203; number_of_response:1; }","duration":"316.796593ms","start":"2026-05-25T10:59:55.779055Z","end":"2026-05-25T10:59:56.095851Z","steps":["trace[1648453154] 'process raft request'  (duration: 316.335905ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T10:59:56.095931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:59:55.779036Z","time spent":"316.865644ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24187 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-05-25T10:59:56.096046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.754994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18368"}
{"level":"info","ts":"2026-05-25T10:59:56.096075Z","caller":"traceutil/trace.go:171","msg":"trace[1088425896] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24203; }","duration":"278.835456ms","start":"2026-05-25T10:59:55.817232Z","end":"2026-05-25T10:59:56.096067Z","steps":["trace[1088425896] 'agreement among raft nodes before linearized reading'  (duration: 278.684553ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:56.170741Z","caller":"traceutil/trace.go:171","msg":"trace[640570656] transaction","detail":"{read_only:false; response_revision:24204; number_of_response:1; }","duration":"173.859243ms","start":"2026-05-25T10:59:55.99686Z","end":"2026-05-25T10:59:56.170719Z","steps":["trace[640570656] 'process raft request'  (duration: 173.68794ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T10:59:56.17103Z","caller":"traceutil/trace.go:171","msg":"trace[107190792] transaction","detail":"{read_only:false; response_revision:24205; number_of_response:1; }","duration":"156.880372ms","start":"2026-05-25T10:59:56.014126Z","end":"2026-05-25T10:59:56.171006Z","steps":["trace[107190792] 'process raft request'  (duration: 156.554996ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:01.70741Z","caller":"traceutil/trace.go:171","msg":"trace[2005838853] linearizableReadLoop","detail":"{readStateIndex:25088; appliedIndex:25087; }","duration":"120.511766ms","start":"2026-05-25T11:00:01.586876Z","end":"2026-05-25T11:00:01.707388Z","steps":["trace[2005838853] 'read index received'  (duration: 120.377464ms)","trace[2005838853] 'applied index is now lower than readState.Index'  (duration: 132.952µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:01.707537Z","caller":"traceutil/trace.go:171","msg":"trace[233350999] transaction","detail":"{read_only:false; response_revision:24293; number_of_response:1; }","duration":"135.471189ms","start":"2026-05-25T11:00:01.572054Z","end":"2026-05-25T11:00:01.707526Z","steps":["trace[233350999] 'process raft request'  (duration: 135.174883ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:01.707763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.871923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-25T11:00:01.707803Z","caller":"traceutil/trace.go:171","msg":"trace[1017635602] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:24293; }","duration":"120.960244ms","start":"2026-05-25T11:00:01.586833Z","end":"2026-05-25T11:00:01.707794Z","steps":["trace[1017635602] 'agreement among raft nodes before linearized reading'  (duration: 120.818402ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:01.708006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.874943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5621"}
{"level":"info","ts":"2026-05-25T11:00:01.708081Z","caller":"traceutil/trace.go:171","msg":"trace[703414347] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:24293; }","duration":"120.990684ms","start":"2026-05-25T11:00:01.587074Z","end":"2026-05-25T11:00:01.708064Z","steps":["trace[703414347] 'agreement among raft nodes before linearized reading'  (duration: 120.782161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:01.708096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.859443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:1 size:5054"}
{"level":"warn","ts":"2026-05-25T11:00:01.708098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.947314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/rabbitmq-nova\" ","response":"range_response_count:1 size:893"}
{"level":"info","ts":"2026-05-25T11:00:01.708164Z","caller":"traceutil/trace.go:171","msg":"trace[1657774137] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:1; response_revision:24293; }","duration":"119.944985ms","start":"2026-05-25T11:00:01.588201Z","end":"2026-05-25T11:00:01.708146Z","steps":["trace[1657774137] 'agreement among raft nodes before linearized reading'  (duration: 119.752071ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:01.70818Z","caller":"traceutil/trace.go:171","msg":"trace[1167013381] range","detail":"{range_begin:/registry/services/endpoints/openstack/rabbitmq-nova; range_end:; response_count:1; response_revision:24293; }","duration":"120.090867ms","start":"2026-05-25T11:00:01.588068Z","end":"2026-05-25T11:00:01.708159Z","steps":["trace[1167013381] 'agreement among raft nodes before linearized reading'  (duration: 119.832072ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:01.70822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.033936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:676"}
{"level":"warn","ts":"2026-05-25T11:00:01.708096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.982916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:1149"}
{"level":"info","ts":"2026-05-25T11:00:01.708274Z","caller":"traceutil/trace.go:171","msg":"trace[181795151] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:24293; }","duration":"120.080307ms","start":"2026-05-25T11:00:01.588167Z","end":"2026-05-25T11:00:01.708247Z","steps":["trace[181795151] 'agreement among raft nodes before linearized reading'  (duration: 119.70382ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:01.7083Z","caller":"traceutil/trace.go:171","msg":"trace[831028542] range","detail":"{range_begin:/registry/services/endpoints/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:24293; }","duration":"120.205659ms","start":"2026-05-25T11:00:01.588079Z","end":"2026-05-25T11:00:01.708285Z","steps":["trace[831028542] 'agreement among raft nodes before linearized reading'  (duration: 119.861043ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:01.979735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.160882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-25T11:00:01.979753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.256407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:01.979829Z","caller":"traceutil/trace.go:171","msg":"trace[733167388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24293; }","duration":"144.307155ms","start":"2026-05-25T11:00:01.835503Z","end":"2026-05-25T11:00:01.97981Z","steps":["trace[733167388] 'range keys from in-memory index tree'  (duration: 143.967679ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:01.979846Z","caller":"traceutil/trace.go:171","msg":"trace[1246994541] 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:24293; }","duration":"214.399779ms","start":"2026-05-25T11:00:01.765425Z","end":"2026-05-25T11:00:01.979825Z","steps":["trace[1246994541] 'range keys from in-memory index tree'  (duration: 214.126224ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:01.979752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.353944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-25T11:00:01.979908Z","caller":"traceutil/trace.go:171","msg":"trace[452806296] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24293; }","duration":"137.521817ms","start":"2026-05-25T11:00:01.842371Z","end":"2026-05-25T11:00:01.979893Z","steps":["trace[452806296] 'range keys from in-memory index tree'  (duration: 137.186431ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.149687Z","caller":"traceutil/trace.go:171","msg":"trace[643260702] linearizableReadLoop","detail":"{readStateIndex:25090; appliedIndex:25088; }","duration":"164.859894ms","start":"2026-05-25T11:00:01.984801Z","end":"2026-05-25T11:00:02.149661Z","steps":["trace[643260702] 'read index received'  (duration: 24.647396ms)","trace[643260702] 'applied index is now lower than readState.Index'  (duration: 140.211418ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:02.149857Z","caller":"traceutil/trace.go:171","msg":"trace[1380820761] transaction","detail":"{read_only:false; response_revision:24295; number_of_response:1; }","duration":"166.036856ms","start":"2026-05-25T11:00:01.983769Z","end":"2026-05-25T11:00:02.149806Z","steps":["trace[1380820761] 'process raft request'  (duration: 152.215985ms)","trace[1380820761] 'compare'  (duration: 13.548456ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:02.149883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.060177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:02.150052Z","caller":"traceutil/trace.go:171","msg":"trace[1601635424] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24295; }","duration":"165.268981ms","start":"2026-05-25T11:00:01.984769Z","end":"2026-05-25T11:00:02.150038Z","steps":["trace[1601635424] 'agreement among raft nodes before linearized reading'  (duration: 164.997107ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.313436Z","caller":"traceutil/trace.go:171","msg":"trace[577782373] linearizableReadLoop","detail":"{readStateIndex:25092; appliedIndex:25090; }","duration":"157.82724ms","start":"2026-05-25T11:00:02.155592Z","end":"2026-05-25T11:00:02.313419Z","steps":["trace[577782373] 'read index received'  (duration: 147.744089ms)","trace[577782373] 'applied index is now lower than readState.Index'  (duration: 10.082461ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:02.31361Z","caller":"traceutil/trace.go:171","msg":"trace[1315689166] transaction","detail":"{read_only:false; response_revision:24296; number_of_response:1; }","duration":"195.996382ms","start":"2026-05-25T11:00:02.117605Z","end":"2026-05-25T11:00:02.313601Z","steps":["trace[1315689166] 'process raft request'  (duration: 185.800529ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:02.313954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.144417ms","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-05-25T11:00:02.313958Z","caller":"traceutil/trace.go:171","msg":"trace[39539596] transaction","detail":"{read_only:false; response_revision:24297; number_of_response:1; }","duration":"195.793298ms","start":"2026-05-25T11:00:02.117923Z","end":"2026-05-25T11:00:02.313716Z","steps":["trace[39539596] 'process raft request'  (duration: 195.462692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.314008Z","caller":"traceutil/trace.go:171","msg":"trace[1877892588] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24297; }","duration":"158.436352ms","start":"2026-05-25T11:00:02.155559Z","end":"2026-05-25T11:00:02.313995Z","steps":["trace[1877892588] 'agreement among raft nodes before linearized reading'  (duration: 158.120836ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.324682Z","caller":"traceutil/trace.go:171","msg":"trace[1045525242] transaction","detail":"{read_only:false; response_revision:24298; number_of_response:1; }","duration":"136.532439ms","start":"2026-05-25T11:00:02.18813Z","end":"2026-05-25T11:00:02.324662Z","steps":["trace[1045525242] 'process raft request'  (duration: 136.294834ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.324727Z","caller":"traceutil/trace.go:171","msg":"trace[667091643] transaction","detail":"{read_only:false; response_revision:24299; number_of_response:1; }","duration":"133.93972ms","start":"2026-05-25T11:00:02.190757Z","end":"2026-05-25T11:00:02.324697Z","steps":["trace[667091643] 'process raft request'  (duration: 133.805268ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.711611Z","caller":"traceutil/trace.go:171","msg":"trace[589158191] linearizableReadLoop","detail":"{readStateIndex:25096; appliedIndex:25095; }","duration":"218.078198ms","start":"2026-05-25T11:00:02.493512Z","end":"2026-05-25T11:00:02.71159Z","steps":["trace[589158191] 'read index received'  (duration: 217.948236ms)","trace[589158191] 'applied index is now lower than readState.Index'  (duration: 128.922µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:02.711818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.286272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-service-cleaner-29661780-hmnfj\" ","response":"range_response_count:1 size:8227"}
{"level":"info","ts":"2026-05-25T11:00:02.711879Z","caller":"traceutil/trace.go:171","msg":"trace[284143241] range","detail":"{range_begin:/registry/pods/openstack/nova-service-cleaner-29661780-hmnfj; range_end:; response_count:1; response_revision:24301; }","duration":"218.378204ms","start":"2026-05-25T11:00:02.493467Z","end":"2026-05-25T11:00:02.711845Z","steps":["trace[284143241] 'agreement among raft nodes before linearized reading'  (duration: 218.214861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.7119Z","caller":"traceutil/trace.go:171","msg":"trace[49423505] transaction","detail":"{read_only:false; response_revision:24301; number_of_response:1; }","duration":"300.847741ms","start":"2026-05-25T11:00:02.411026Z","end":"2026-05-25T11:00:02.711874Z","steps":["trace[49423505] 'process raft request'  (duration: 300.421314ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:02.71204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:02.411014Z","time spent":"300.950303ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24271 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-25T11:00:02.737439Z","caller":"traceutil/trace.go:171","msg":"trace[964358848] transaction","detail":"{read_only:false; response_revision:24302; number_of_response:1; }","duration":"243.266203ms","start":"2026-05-25T11:00:02.494146Z","end":"2026-05-25T11:00:02.737413Z","steps":["trace[964358848] 'process raft request'  (duration: 243.09381ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:02.955476Z","caller":"traceutil/trace.go:171","msg":"trace[736430207] linearizableReadLoop","detail":"{readStateIndex:25098; appliedIndex:25097; }","duration":"210.873412ms","start":"2026-05-25T11:00:02.744576Z","end":"2026-05-25T11:00:02.95545Z","steps":["trace[736430207] 'read index received'  (duration: 210.684198ms)","trace[736430207] 'applied index is now lower than readState.Index'  (duration: 187.624µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:02.95558Z","caller":"traceutil/trace.go:171","msg":"trace[1839402906] transaction","detail":"{read_only:false; response_revision:24303; number_of_response:1; }","duration":"232.48948ms","start":"2026-05-25T11:00:02.723054Z","end":"2026-05-25T11:00:02.955544Z","steps":["trace[1839402906] 'process raft request'  (duration: 232.228496ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:02.955673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.070085ms","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-05-25T11:00:02.955714Z","caller":"traceutil/trace.go:171","msg":"trace[1555563864] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:24303; }","duration":"211.159747ms","start":"2026-05-25T11:00:02.744542Z","end":"2026-05-25T11:00:02.955702Z","steps":["trace[1555563864] 'agreement among raft nodes before linearized reading'  (duration: 211.072106ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:02.955835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.123628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:02.955897Z","caller":"traceutil/trace.go:171","msg":"trace[1034774352] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:24303; }","duration":"200.227321ms","start":"2026-05-25T11:00:02.755655Z","end":"2026-05-25T11:00:02.955882Z","steps":["trace[1034774352] 'agreement among raft nodes before linearized reading'  (duration: 200.128879ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:03.317674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.782375ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481436 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24280 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:03.317891Z","caller":"traceutil/trace.go:171","msg":"trace[1876677235] transaction","detail":"{read_only:false; response_revision:24305; number_of_response:1; }","duration":"299.69437ms","start":"2026-05-25T11:00:03.018153Z","end":"2026-05-25T11:00:03.317847Z","steps":["trace[1876677235] 'process raft request'  (duration: 164.633559ms)","trace[1876677235] 'compare'  (duration: 134.419159ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:03.318059Z","caller":"traceutil/trace.go:171","msg":"trace[508884213] transaction","detail":"{read_only:false; response_revision:24306; number_of_response:1; }","duration":"299.474715ms","start":"2026-05-25T11:00:03.018563Z","end":"2026-05-25T11:00:03.318037Z","steps":["trace[508884213] 'process raft request'  (duration: 299.22022ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:03.996564Z","caller":"traceutil/trace.go:171","msg":"trace[1328696442] linearizableReadLoop","detail":"{readStateIndex:25102; appliedIndex:25101; }","duration":"118.072481ms","start":"2026-05-25T11:00:03.878466Z","end":"2026-05-25T11:00:03.996538Z","steps":["trace[1328696442] 'read index received'  (duration: 117.811166ms)","trace[1328696442] 'applied index is now lower than readState.Index'  (duration: 260.125µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:03.996696Z","caller":"traceutil/trace.go:171","msg":"trace[233382873] transaction","detail":"{read_only:false; response_revision:24307; number_of_response:1; }","duration":"284.35251ms","start":"2026-05-25T11:00:03.712313Z","end":"2026-05-25T11:00:03.996665Z","steps":["trace[233382873] 'process raft request'  (duration: 284.052485ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:03.996754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.267374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:03.996796Z","caller":"traceutil/trace.go:171","msg":"trace[352320716] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24307; }","duration":"118.360475ms","start":"2026-05-25T11:00:03.87842Z","end":"2026-05-25T11:00:03.996781Z","steps":["trace[352320716] 'agreement among raft nodes before linearized reading'  (duration: 118.249213ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:03.996997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.836822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.212\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-25T11:00:03.997037Z","caller":"traceutil/trace.go:171","msg":"trace[1729643806] range","detail":"{range_begin:/registry/masterleases/199.19.213.212; range_end:; response_count:1; response_revision:24307; }","duration":"112.098257ms","start":"2026-05-25T11:00:03.884928Z","end":"2026-05-25T11:00:03.997026Z","steps":["trace[1729643806] 'agreement among raft nodes before linearized reading'  (duration: 111.750651ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:04.197237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.231885ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481445 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.212\" mod_revision:24188 > success:<request_put:<key:\"/registry/masterleases/199.19.213.212\" value_size:68 lease:854732158543481442 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.212\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:04.197945Z","caller":"traceutil/trace.go:171","msg":"trace[1090086496] transaction","detail":"{read_only:false; response_revision:24309; number_of_response:1; }","duration":"178.241786ms","start":"2026-05-25T11:00:04.019681Z","end":"2026-05-25T11:00:04.197923Z","steps":["trace[1090086496] 'process raft request'  (duration: 177.688825ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:04.198005Z","caller":"traceutil/trace.go:171","msg":"trace[893158968] transaction","detail":"{read_only:false; response_revision:24308; number_of_response:1; }","duration":"181.07895ms","start":"2026-05-25T11:00:04.016897Z","end":"2026-05-25T11:00:04.197976Z","steps":["trace[893158968] 'process raft request'  (duration: 54.994399ms)","trace[893158968] 'compare'  (duration: 124.9634ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:04.544454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.042516ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481450 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24295 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:04.544573Z","caller":"traceutil/trace.go:171","msg":"trace[1122893794] transaction","detail":"{read_only:false; response_revision:24310; number_of_response:1; }","duration":"340.754335ms","start":"2026-05-25T11:00:04.203792Z","end":"2026-05-25T11:00:04.544546Z","steps":["trace[1122893794] 'process raft request'  (duration: 111.551706ms)","trace[1122893794] 'compare'  (duration: 228.949104ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:04.544608Z","caller":"traceutil/trace.go:171","msg":"trace[54345043] transaction","detail":"{read_only:false; response_revision:24311; number_of_response:1; }","duration":"226.908195ms","start":"2026-05-25T11:00:04.317685Z","end":"2026-05-25T11:00:04.544594Z","steps":["trace[54345043] 'process raft request'  (duration: 226.867884ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:04.544648Z","caller":"traceutil/trace.go:171","msg":"trace[1354343885] linearizableReadLoop","detail":"{readStateIndex:25106; appliedIndex:25105; }","duration":"339.998361ms","start":"2026-05-25T11:00:04.204634Z","end":"2026-05-25T11:00:04.544632Z","steps":["trace[1354343885] 'read index received'  (duration: 110.6782ms)","trace[1354343885] 'applied index is now lower than readState.Index'  (duration: 229.318841ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:04.544691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:04.203759Z","time spent":"340.867597ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24295 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-25T11:00:04.544853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.219725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-25T11:00:04.544893Z","caller":"traceutil/trace.go:171","msg":"trace[813708079] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24311; }","duration":"340.293207ms","start":"2026-05-25T11:00:04.204591Z","end":"2026-05-25T11:00:04.544884Z","steps":["trace[813708079] 'agreement among raft nodes before linearized reading'  (duration: 340.122434ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:04.544921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:04.20458Z","time spent":"340.334097ms","remote":"127.0.0.1:32992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"info","ts":"2026-05-25T11:00:04.558051Z","caller":"traceutil/trace.go:171","msg":"trace[1545827362] transaction","detail":"{read_only:false; response_revision:24314; number_of_response:1; }","duration":"229.018785ms","start":"2026-05-25T11:00:04.328984Z","end":"2026-05-25T11:00:04.558003Z","steps":["trace[1545827362] 'process raft request'  (duration: 228.881033ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:04.558135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.846829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:04.558143Z","caller":"traceutil/trace.go:171","msg":"trace[1062458215] transaction","detail":"{read_only:false; response_revision:24315; number_of_response:1; }","duration":"177.36608ms","start":"2026-05-25T11:00:04.380758Z","end":"2026-05-25T11:00:04.558124Z","steps":["trace[1062458215] 'process raft request'  (duration: 177.138806ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:04.558186Z","caller":"traceutil/trace.go:171","msg":"trace[1879814541] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24315; }","duration":"176.911131ms","start":"2026-05-25T11:00:04.381253Z","end":"2026-05-25T11:00:04.558164Z","steps":["trace[1879814541] 'agreement among raft nodes before linearized reading'  (duration: 176.85143ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:04.558213Z","caller":"traceutil/trace.go:171","msg":"trace[314741190] transaction","detail":"{read_only:false; response_revision:24312; number_of_response:1; }","duration":"239.951481ms","start":"2026-05-25T11:00:04.318215Z","end":"2026-05-25T11:00:04.558166Z","steps":["trace[314741190] 'process raft request'  (duration: 239.414221ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:04.558061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.30627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:04.558317Z","caller":"traceutil/trace.go:171","msg":"trace[1999817727] transaction","detail":"{read_only:false; response_revision:24313; number_of_response:1; }","duration":"230.107715ms","start":"2026-05-25T11:00:04.328098Z","end":"2026-05-25T11:00:04.558206Z","steps":["trace[1999817727] 'process raft request'  (duration: 229.662967ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:04.558324Z","caller":"traceutil/trace.go:171","msg":"trace[161477007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24315; }","duration":"274.571015ms","start":"2026-05-25T11:00:04.283717Z","end":"2026-05-25T11:00:04.558288Z","steps":["trace[161477007] 'agreement among raft nodes before linearized reading'  (duration: 274.227189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:04.558081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.997623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:04.558398Z","caller":"traceutil/trace.go:171","msg":"trace[316759553] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24315; }","duration":"114.35941ms","start":"2026-05-25T11:00:04.444018Z","end":"2026-05-25T11:00:04.558377Z","steps":["trace[316759553] 'agreement among raft nodes before linearized reading'  (duration: 113.995563ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:04.874624Z","caller":"traceutil/trace.go:171","msg":"trace[1192247778] transaction","detail":"{read_only:false; response_revision:24317; number_of_response:1; }","duration":"132.815898ms","start":"2026-05-25T11:00:04.741783Z","end":"2026-05-25T11:00:04.874599Z","steps":["trace[1192247778] 'process raft request'  (duration: 131.697647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.146545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.016166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-25T11:00:05.146613Z","caller":"traceutil/trace.go:171","msg":"trace[562298622] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24317; }","duration":"129.147609ms","start":"2026-05-25T11:00:05.017446Z","end":"2026-05-25T11:00:05.146594Z","steps":["trace[562298622] 'range keys from in-memory index tree'  (duration: 128.66721ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:05.381514Z","caller":"traceutil/trace.go:171","msg":"trace[90968900] transaction","detail":"{read_only:false; response_revision:24318; number_of_response:1; }","duration":"231.197806ms","start":"2026-05-25T11:00:05.150297Z","end":"2026-05-25T11:00:05.381494Z","steps":["trace[90968900] 'process raft request'  (duration: 231.019493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.641191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.803572ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481465 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24269 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:05.641357Z","caller":"traceutil/trace.go:171","msg":"trace[223525981] linearizableReadLoop","detail":"{readStateIndex:25115; appliedIndex:25113; }","duration":"357.882869ms","start":"2026-05-25T11:00:05.283455Z","end":"2026-05-25T11:00:05.641338Z","steps":["trace[223525981] 'read index received'  (duration: 98.003161ms)","trace[223525981] 'applied index is now lower than readState.Index'  (duration: 259.877478ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:05.641479Z","caller":"traceutil/trace.go:171","msg":"trace[892994135] transaction","detail":"{read_only:false; response_revision:24319; number_of_response:1; }","duration":"404.122862ms","start":"2026-05-25T11:00:05.237344Z","end":"2026-05-25T11:00:05.641466Z","steps":["trace[892994135] 'process raft request'  (duration: 301.939372ms)","trace[892994135] 'compare'  (duration: 101.429615ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:05.641579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:05.23732Z","time spent":"404.220324ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24269 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-25T11:00:05.641939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.303554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:05.642021Z","caller":"traceutil/trace.go:171","msg":"trace[593065432] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:24319; }","duration":"262.447735ms","start":"2026-05-25T11:00:05.379552Z","end":"2026-05-25T11:00:05.641999Z","steps":["trace[593065432] 'agreement among raft nodes before linearized reading'  (duration: 262.308493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.641978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.516621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-25T11:00:05.642103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.432883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-25T11:00:05.64221Z","caller":"traceutil/trace.go:171","msg":"trace[931958670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24319; }","duration":"319.559034ms","start":"2026-05-25T11:00:05.322609Z","end":"2026-05-25T11:00:05.642168Z","steps":["trace[931958670] 'agreement among raft nodes before linearized reading'  (duration: 319.123296ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.64226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:05.322596Z","time spent":"319.652716ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-25T11:00:05.642121Z","caller":"traceutil/trace.go:171","msg":"trace[308951127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24319; }","duration":"358.695523ms","start":"2026-05-25T11:00:05.283413Z","end":"2026-05-25T11:00:05.642109Z","steps":["trace[308951127] 'agreement among raft nodes before linearized reading'  (duration: 358.51799ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.642389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:05.283398Z","time spent":"358.979379ms","remote":"127.0.0.1:60978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-25T11:00:05.642414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.699717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-05-25T11:00:05.642547Z","caller":"traceutil/trace.go:171","msg":"trace[937819049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24319; }","duration":"319.851019ms","start":"2026-05-25T11:00:05.322648Z","end":"2026-05-25T11:00:05.642499Z","steps":["trace[937819049] 'agreement among raft nodes before linearized reading'  (duration: 319.433592ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.642628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:05.322646Z","time spent":"319.969461ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-25T11:00:05.884143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.155346ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481469 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24305 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:05.884416Z","caller":"traceutil/trace.go:171","msg":"trace[37774900] linearizableReadLoop","detail":"{readStateIndex:25117; appliedIndex:25115; }","duration":"228.735039ms","start":"2026-05-25T11:00:05.655658Z","end":"2026-05-25T11:00:05.884393Z","steps":["trace[37774900] 'read index received'  (duration: 123.205177ms)","trace[37774900] 'applied index is now lower than readState.Index'  (duration: 105.528452ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:05.884477Z","caller":"traceutil/trace.go:171","msg":"trace[539635513] transaction","detail":"{read_only:false; response_revision:24321; number_of_response:1; }","duration":"237.75863ms","start":"2026-05-25T11:00:05.646685Z","end":"2026-05-25T11:00:05.884444Z","steps":["trace[539635513] 'process raft request'  (duration: 237.603377ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:05.884585Z","caller":"traceutil/trace.go:171","msg":"trace[1937821443] transaction","detail":"{read_only:false; response_revision:24320; number_of_response:1; }","duration":"238.555274ms","start":"2026-05-25T11:00:05.645985Z","end":"2026-05-25T11:00:05.884541Z","steps":["trace[1937821443] 'process raft request'  (duration: 132.888439ms)","trace[1937821443] 'compare'  (duration: 105.002753ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:05.884831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.163567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418324"}
{"level":"info","ts":"2026-05-25T11:00:05.884918Z","caller":"traceutil/trace.go:171","msg":"trace[1554919564] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:24321; }","duration":"229.262168ms","start":"2026-05-25T11:00:05.655614Z","end":"2026-05-25T11:00:05.884876Z","steps":["trace[1554919564] 'agreement among raft nodes before linearized reading'  (duration: 228.903572ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:05.884878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.094595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-05-25T11:00:05.885011Z","caller":"traceutil/trace.go:171","msg":"trace[500506482] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24321; }","duration":"194.249198ms","start":"2026-05-25T11:00:05.690744Z","end":"2026-05-25T11:00:05.884994Z","steps":["trace[500506482] 'agreement among raft nodes before linearized reading'  (duration: 193.924921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.378176Z","caller":"traceutil/trace.go:171","msg":"trace[2040605730] linearizableReadLoop","detail":"{readStateIndex:25119; appliedIndex:25118; }","duration":"176.643965ms","start":"2026-05-25T11:00:06.201507Z","end":"2026-05-25T11:00:06.378151Z","steps":["trace[2040605730] 'read index received'  (duration: 176.528993ms)","trace[2040605730] 'applied index is now lower than readState.Index'  (duration: 113.962µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:06.378307Z","caller":"traceutil/trace.go:171","msg":"trace[1419522623] transaction","detail":"{read_only:false; response_revision:24323; number_of_response:1; }","duration":"377.014059ms","start":"2026-05-25T11:00:06.001245Z","end":"2026-05-25T11:00:06.37826Z","steps":["trace[1419522623] 'process raft request'  (duration: 376.712944ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.3784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.87022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-25T11:00:06.378432Z","caller":"traceutil/trace.go:171","msg":"trace[1582220644] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24323; }","duration":"176.955711ms","start":"2026-05-25T11:00:06.201467Z","end":"2026-05-25T11:00:06.378422Z","steps":["trace[1582220644] 'agreement among raft nodes before linearized reading'  (duration: 176.797868ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.378458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:06.001221Z","time spent":"377.157472ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24307 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-25T11:00:06.543027Z","caller":"traceutil/trace.go:171","msg":"trace[1435514338] linearizableReadLoop","detail":"{readStateIndex:25120; appliedIndex:25119; }","duration":"164.766322ms","start":"2026-05-25T11:00:06.378241Z","end":"2026-05-25T11:00:06.543007Z","steps":["trace[1435514338] 'read index received'  (duration: 164.395814ms)","trace[1435514338] 'applied index is now lower than readState.Index'  (duration: 369.668µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:06.54308Z","caller":"traceutil/trace.go:171","msg":"trace[2146625736] transaction","detail":"{read_only:false; response_revision:24324; number_of_response:1; }","duration":"271.221123ms","start":"2026-05-25T11:00:06.271823Z","end":"2026-05-25T11:00:06.543044Z","steps":["trace[2146625736] 'process raft request'  (duration: 270.904476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.543211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.915113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-25T11:00:06.543259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.213123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-25T11:00:06.543278Z","caller":"traceutil/trace.go:171","msg":"trace[1884358143] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:24324; }","duration":"328.032626ms","start":"2026-05-25T11:00:06.215228Z","end":"2026-05-25T11:00:06.54326Z","steps":["trace[1884358143] 'agreement among raft nodes before linearized reading'  (duration: 327.884923ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.54331Z","caller":"traceutil/trace.go:171","msg":"trace[1018397112] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24324; }","duration":"225.282424ms","start":"2026-05-25T11:00:06.318014Z","end":"2026-05-25T11:00:06.543297Z","steps":["trace[1018397112] 'agreement among raft nodes before linearized reading'  (duration: 225.06289ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.543326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:06.215211Z","time spent":"328.096086ms","remote":"127.0.0.1:47374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "}
{"level":"info","ts":"2026-05-25T11:00:06.585219Z","caller":"traceutil/trace.go:171","msg":"trace[1842357544] transaction","detail":"{read_only:false; response_revision:24325; number_of_response:1; }","duration":"202.527386ms","start":"2026-05-25T11:00:06.382658Z","end":"2026-05-25T11:00:06.585185Z","steps":["trace[1842357544] 'process raft request'  (duration: 202.29348ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.585249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.966594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:06.585432Z","caller":"traceutil/trace.go:171","msg":"trace[927898822] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:24325; }","duration":"157.195599ms","start":"2026-05-25T11:00:06.428219Z","end":"2026-05-25T11:00:06.585414Z","steps":["trace[927898822] 'agreement among raft nodes before linearized reading'  (duration: 156.964344ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.70276Z","caller":"traceutil/trace.go:171","msg":"trace[117169868] transaction","detail":"{read_only:false; response_revision:24326; number_of_response:1; }","duration":"153.324626ms","start":"2026-05-25T11:00:06.549411Z","end":"2026-05-25T11:00:06.702736Z","steps":["trace[117169868] 'process raft request'  (duration: 153.132922ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.703024Z","caller":"traceutil/trace.go:171","msg":"trace[2045617713] transaction","detail":"{read_only:false; response_revision:24327; number_of_response:1; }","duration":"139.594616ms","start":"2026-05-25T11:00:06.5634Z","end":"2026-05-25T11:00:06.702994Z","steps":["trace[2045617713] 'process raft request'  (duration: 139.2828ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.703058Z","caller":"traceutil/trace.go:171","msg":"trace[1233759113] transaction","detail":"{read_only:false; response_revision:24328; number_of_response:1; }","duration":"139.564386ms","start":"2026-05-25T11:00:06.563471Z","end":"2026-05-25T11:00:06.703035Z","steps":["trace[1233759113] 'process raft request'  (duration: 139.425133ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.703235Z","caller":"traceutil/trace.go:171","msg":"trace[1364990369] transaction","detail":"{read_only:false; response_revision:24330; number_of_response:1; }","duration":"139.544265ms","start":"2026-05-25T11:00:06.563679Z","end":"2026-05-25T11:00:06.703224Z","steps":["trace[1364990369] 'process raft request'  (duration: 139.434363ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:06.703223Z","caller":"traceutil/trace.go:171","msg":"trace[1138908532] linearizableReadLoop","detail":"{readStateIndex:25126; appliedIndex:25121; }","duration":"118.10435ms","start":"2026-05-25T11:00:06.585095Z","end":"2026-05-25T11:00:06.7032Z","steps":["trace[1138908532] 'read index received'  (duration: 117.389186ms)","trace[1138908532] 'applied index is now lower than readState.Index'  (duration: 714.214µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:06.703258Z","caller":"traceutil/trace.go:171","msg":"trace[727924290] transaction","detail":"{read_only:false; response_revision:24329; number_of_response:1; }","duration":"139.579416ms","start":"2026-05-25T11:00:06.563638Z","end":"2026-05-25T11:00:06.703217Z","steps":["trace[727924290] 'process raft request'  (duration: 139.354972ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.703428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.497176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-25T11:00:06.703489Z","caller":"traceutil/trace.go:171","msg":"trace[989128089] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24330; }","duration":"156.598388ms","start":"2026-05-25T11:00:06.54688Z","end":"2026-05-25T11:00:06.703479Z","steps":["trace[989128089] 'agreement among raft nodes before linearized reading'  (duration: 156.413205ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:06.70535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.080137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-25T11:00:06.705445Z","caller":"traceutil/trace.go:171","msg":"trace[82290101] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24330; }","duration":"157.199799ms","start":"2026-05-25T11:00:06.548223Z","end":"2026-05-25T11:00:06.705422Z","steps":["trace[82290101] 'agreement among raft nodes before linearized reading'  (duration: 155.025368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:11.560925Z","caller":"traceutil/trace.go:171","msg":"trace[1428860611] transaction","detail":"{read_only:false; response_revision:24383; number_of_response:1; }","duration":"148.84106ms","start":"2026-05-25T11:00:11.412059Z","end":"2026-05-25T11:00:11.5609Z","steps":["trace[1428860611] 'process raft request'  (duration: 148.720658ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:11.878097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.949818ms","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-05-25T11:00:11.878179Z","caller":"traceutil/trace.go:171","msg":"trace[666410563] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:24383; }","duration":"189.086441ms","start":"2026-05-25T11:00:11.689073Z","end":"2026-05-25T11:00:11.878159Z","steps":["trace[666410563] 'count revisions from in-memory index tree'  (duration: 188.858697ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:12.050674Z","caller":"traceutil/trace.go:171","msg":"trace[1476715214] transaction","detail":"{read_only:false; response_revision:24385; number_of_response:1; }","duration":"134.392118ms","start":"2026-05-25T11:00:11.916258Z","end":"2026-05-25T11:00:12.05065Z","steps":["trace[1476715214] 'process raft request'  (duration: 133.850099ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:12.295498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.592008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-25T11:00:12.295619Z","caller":"traceutil/trace.go:171","msg":"trace[426368377] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24385; }","duration":"192.74384ms","start":"2026-05-25T11:00:12.102838Z","end":"2026-05-25T11:00:12.295582Z","steps":["trace[426368377] 'range keys from in-memory index tree'  (duration: 192.401573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:12.729327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.807998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:12.729394Z","caller":"traceutil/trace.go:171","msg":"trace[1404217771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24386; }","duration":"177.92726ms","start":"2026-05-25T11:00:12.551453Z","end":"2026-05-25T11:00:12.72938Z","steps":["trace[1404217771] 'range keys from in-memory index tree'  (duration: 177.618935ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:12.729629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.176908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-25T11:00:12.729611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.148897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-05-25T11:00:12.729729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.724606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:12.729659Z","caller":"traceutil/trace.go:171","msg":"trace[380027781] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:24386; }","duration":"202.248649ms","start":"2026-05-25T11:00:12.527399Z","end":"2026-05-25T11:00:12.729648Z","steps":["trace[380027781] 'count revisions from in-memory index tree'  (duration: 202.081296ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:12.729843Z","caller":"traceutil/trace.go:171","msg":"trace[1169001616] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:24386; }","duration":"195.900519ms","start":"2026-05-25T11:00:12.53392Z","end":"2026-05-25T11:00:12.729821Z","steps":["trace[1169001616] 'count revisions from in-memory index tree'  (duration: 195.650265ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:12.729736Z","caller":"traceutil/trace.go:171","msg":"trace[817198968] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24386; }","duration":"122.292739ms","start":"2026-05-25T11:00:12.607409Z","end":"2026-05-25T11:00:12.729702Z","steps":["trace[817198968] 'range keys from in-memory index tree'  (duration: 121.832221ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.158633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.218058ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481613 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24379 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:13.158806Z","caller":"traceutil/trace.go:171","msg":"trace[1674990894] linearizableReadLoop","detail":"{readStateIndex:25189; appliedIndex:25184; }","duration":"408.633397ms","start":"2026-05-25T11:00:12.750163Z","end":"2026-05-25T11:00:13.158796Z","steps":["trace[1674990894] 'read index received'  (duration: 27.667513ms)","trace[1674990894] 'applied index is now lower than readState.Index'  (duration: 380.965394ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:13.15885Z","caller":"traceutil/trace.go:171","msg":"trace[620352182] transaction","detail":"{read_only:false; response_revision:24391; number_of_response:1; }","duration":"418.28793ms","start":"2026-05-25T11:00:12.740557Z","end":"2026-05-25T11:00:13.158845Z","steps":["trace[620352182] 'process raft request'  (duration: 418.195948ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:13.158841Z","caller":"traceutil/trace.go:171","msg":"trace[365510504] transaction","detail":"{read_only:false; response_revision:24390; number_of_response:1; }","duration":"418.390222ms","start":"2026-05-25T11:00:12.740428Z","end":"2026-05-25T11:00:13.158818Z","steps":["trace[365510504] 'process raft request'  (duration: 418.269269ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:13.158913Z","caller":"traceutil/trace.go:171","msg":"trace[1046107611] transaction","detail":"{read_only:false; response_revision:24392; number_of_response:1; }","duration":"417.712729ms","start":"2026-05-25T11:00:12.741194Z","end":"2026-05-25T11:00:13.158907Z","steps":["trace[1046107611] 'process raft request'  (duration: 417.579107ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.158939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.741187Z","time spent":"417.7385ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24377 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-25T11:00:13.159106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.947323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-05-25T11:00:13.158889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.740552Z","time spent":"418.320041ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24378 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-25T11:00:13.159127Z","caller":"traceutil/trace.go:171","msg":"trace[803323087] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24392; }","duration":"408.967963ms","start":"2026-05-25T11:00:12.750154Z","end":"2026-05-25T11:00:13.159122Z","steps":["trace[803323087] 'agreement among raft nodes before linearized reading'  (duration: 408.880632ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.159143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.750119Z","time spent":"409.020575ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-25T11:00:13.159086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.740423Z","time spent":"418.498644ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24376 > 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-05-25T11:00:13.159331Z","caller":"traceutil/trace.go:171","msg":"trace[1835713484] transaction","detail":"{read_only:false; response_revision:24389; number_of_response:1; }","duration":"418.961462ms","start":"2026-05-25T11:00:12.740364Z","end":"2026-05-25T11:00:13.159325Z","steps":["trace[1835713484] 'process raft request'  (duration: 107.993089ms)","trace[1835713484] 'compare'  (duration: 309.936813ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:13.159365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.740344Z","time spent":"419.004192ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24379 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-25T11:00:13.321254Z","caller":"traceutil/trace.go:171","msg":"trace[1389523712] transaction","detail":"{read_only:false; response_revision:24394; number_of_response:1; }","duration":"156.780661ms","start":"2026-05-25T11:00:13.16445Z","end":"2026-05-25T11:00:13.321231Z","steps":["trace[1389523712] 'process raft request'  (duration: 156.75083ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:13.321599Z","caller":"traceutil/trace.go:171","msg":"trace[1740841240] transaction","detail":"{read_only:false; response_revision:24393; number_of_response:1; }","duration":"413.115412ms","start":"2026-05-25T11:00:12.908477Z","end":"2026-05-25T11:00:13.321592Z","steps":["trace[1740841240] 'process raft request'  (duration: 412.592032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.321688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.90846Z","time spent":"413.162403ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24382 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-25T11:00:13.321765Z","caller":"traceutil/trace.go:171","msg":"trace[87276516] linearizableReadLoop","detail":"{readStateIndex:25190; appliedIndex:25189; }","duration":"162.915916ms","start":"2026-05-25T11:00:13.158825Z","end":"2026-05-25T11:00:13.321741Z","steps":["trace[87276516] 'read index received'  (duration: 162.180722ms)","trace[87276516] 'applied index is now lower than readState.Index'  (duration: 733.124µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:13.321913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.134148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:13.321945Z","caller":"traceutil/trace.go:171","msg":"trace[785154830] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24394; }","duration":"524.19313ms","start":"2026-05-25T11:00:12.797743Z","end":"2026-05-25T11:00:13.321936Z","steps":["trace[785154830] 'agreement among raft nodes before linearized reading'  (duration: 524.137349ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.321964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.797726Z","time spent":"524.23369ms","remote":"127.0.0.1:60170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true "}
{"level":"warn","ts":"2026-05-25T11:00:13.32208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.113394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:13.322103Z","caller":"traceutil/trace.go:171","msg":"trace[1438893804] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24394; }","duration":"330.166876ms","start":"2026-05-25T11:00:12.991931Z","end":"2026-05-25T11:00:13.322098Z","steps":["trace[1438893804] 'agreement among raft nodes before linearized reading'  (duration: 330.124515ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.32212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.991915Z","time spent":"330.200366ms","remote":"127.0.0.1:59318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-25T11:00:13.322264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.186461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-25T11:00:13.322333Z","caller":"traceutil/trace.go:171","msg":"trace[1049287688] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24394; }","duration":"513.263062ms","start":"2026-05-25T11:00:12.809041Z","end":"2026-05-25T11:00:13.322304Z","steps":["trace[1049287688] 'agreement among raft nodes before linearized reading'  (duration: 513.10617ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:13.322372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:12.809031Z","time spent":"513.333584ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-25T11:00:15.344935Z","caller":"traceutil/trace.go:171","msg":"trace[1757559506] transaction","detail":"{read_only:false; response_revision:24406; number_of_response:1; }","duration":"178.787647ms","start":"2026-05-25T11:00:15.166125Z","end":"2026-05-25T11:00:15.344913Z","steps":["trace[1757559506] 'process raft request'  (duration: 178.648744ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:15.35756Z","caller":"traceutil/trace.go:171","msg":"trace[63259524] linearizableReadLoop","detail":"{readStateIndex:25207; appliedIndex:25203; }","duration":"184.182149ms","start":"2026-05-25T11:00:15.17335Z","end":"2026-05-25T11:00:15.357532Z","steps":["trace[63259524] 'read index received'  (duration: 171.422948ms)","trace[63259524] 'applied index is now lower than readState.Index'  (duration: 12.758281ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:15.357917Z","caller":"traceutil/trace.go:171","msg":"trace[932697151] transaction","detail":"{read_only:false; response_revision:24407; number_of_response:1; }","duration":"191.283622ms","start":"2026-05-25T11:00:15.166618Z","end":"2026-05-25T11:00:15.357901Z","steps":["trace[932697151] 'process raft request'  (duration: 190.692311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:15.358081Z","caller":"traceutil/trace.go:171","msg":"trace[1912275891] transaction","detail":"{read_only:false; response_revision:24408; number_of_response:1; }","duration":"191.263012ms","start":"2026-05-25T11:00:15.166807Z","end":"2026-05-25T11:00:15.35807Z","steps":["trace[1912275891] 'process raft request'  (duration: 190.59889ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:15.358194Z","caller":"traceutil/trace.go:171","msg":"trace[478118669] transaction","detail":"{read_only:false; response_revision:24409; number_of_response:1; }","duration":"191.326313ms","start":"2026-05-25T11:00:15.16686Z","end":"2026-05-25T11:00:15.358186Z","steps":["trace[478118669] 'process raft request'  (duration: 190.582389ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:15.35841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.038256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:15.358443Z","caller":"traceutil/trace.go:171","msg":"trace[1253469537] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24410; }","duration":"185.108746ms","start":"2026-05-25T11:00:15.173324Z","end":"2026-05-25T11:00:15.358433Z","steps":["trace[1253469537] 'agreement among raft nodes before linearized reading'  (duration: 185.034775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:16.135731Z","caller":"traceutil/trace.go:171","msg":"trace[1307447054] transaction","detail":"{read_only:false; response_revision:24416; number_of_response:1; }","duration":"127.366575ms","start":"2026-05-25T11:00:16.008342Z","end":"2026-05-25T11:00:16.135708Z","steps":["trace[1307447054] 'process raft request'  (duration: 126.863235ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:20.411695Z","caller":"traceutil/trace.go:171","msg":"trace[1564479767] transaction","detail":"{read_only:false; response_revision:24452; number_of_response:1; }","duration":"255.965374ms","start":"2026-05-25T11:00:20.155703Z","end":"2026-05-25T11:00:20.411668Z","steps":["trace[1564479767] 'process raft request'  (duration: 255.77251ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:20.560168Z","caller":"traceutil/trace.go:171","msg":"trace[1075896637] transaction","detail":"{read_only:false; response_revision:24454; number_of_response:1; }","duration":"100.332145ms","start":"2026-05-25T11:00:20.459813Z","end":"2026-05-25T11:00:20.560145Z","steps":["trace[1075896637] 'process raft request'  (duration: 100.257793ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:20.560201Z","caller":"traceutil/trace.go:171","msg":"trace[1712918444] transaction","detail":"{read_only:false; response_revision:24453; number_of_response:1; }","duration":"403.469659ms","start":"2026-05-25T11:00:20.156702Z","end":"2026-05-25T11:00:20.560172Z","steps":["trace[1712918444] 'process raft request'  (duration: 351.272024ms)","trace[1712918444] 'compare'  (duration: 51.987951ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:20.560313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:20.156685Z","time spent":"403.566511ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24440 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-25T11:00:20.560331Z","caller":"traceutil/trace.go:171","msg":"trace[602254437] linearizableReadLoop","detail":"{readStateIndex:25252; appliedIndex:25250; }","duration":"205.916199ms","start":"2026-05-25T11:00:20.354395Z","end":"2026-05-25T11:00:20.560311Z","steps":["trace[602254437] 'read index received'  (duration: 57.14864ms)","trace[602254437] 'applied index is now lower than readState.Index'  (duration: 148.766359ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:20.560461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.052041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-25T11:00:20.560488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.290748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:20.56051Z","caller":"traceutil/trace.go:171","msg":"trace[1400345937] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:24454; }","duration":"206.131732ms","start":"2026-05-25T11:00:20.354362Z","end":"2026-05-25T11:00:20.560493Z","steps":["trace[1400345937] 'agreement among raft nodes before linearized reading'  (duration: 206.054921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:20.560535Z","caller":"traceutil/trace.go:171","msg":"trace[1962313374] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:24454; }","duration":"186.37138ms","start":"2026-05-25T11:00:20.374148Z","end":"2026-05-25T11:00:20.560519Z","steps":["trace[1962313374] 'agreement among raft nodes before linearized reading'  (duration: 186.287088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:22.148543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.163475ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543481899 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18b2c9ecdb4b3a86\" mod_revision:24515 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18b2c9ecdb4b3a86\" value_size:647 lease:854732158543481267 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18b2c9ecdb4b3a86\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:00:22.14865Z","caller":"traceutil/trace.go:171","msg":"trace[1452936307] linearizableReadLoop","detail":"{readStateIndex:25318; appliedIndex:25317; }","duration":"183.305212ms","start":"2026-05-25T11:00:21.965327Z","end":"2026-05-25T11:00:22.148632Z","steps":["trace[1452936307] 'read index received'  (duration: 68.903002ms)","trace[1452936307] 'applied index is now lower than readState.Index'  (duration: 114.40022ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:22.1487Z","caller":"traceutil/trace.go:171","msg":"trace[1251251543] transaction","detail":"{read_only:false; response_revision:24519; number_of_response:1; }","duration":"194.36175ms","start":"2026-05-25T11:00:21.95429Z","end":"2026-05-25T11:00:22.148651Z","steps":["trace[1251251543] 'process raft request'  (duration: 79.991341ms)","trace[1251251543] 'compare'  (duration: 113.84854ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:22.148828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.480945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9602"}
{"level":"info","ts":"2026-05-25T11:00:22.14892Z","caller":"traceutil/trace.go:171","msg":"trace[1362480256] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24519; }","duration":"183.609579ms","start":"2026-05-25T11:00:21.965289Z","end":"2026-05-25T11:00:22.148898Z","steps":["trace[1362480256] 'agreement among raft nodes before linearized reading'  (duration: 183.396384ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:22.150083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.686003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224964"}
{"level":"info","ts":"2026-05-25T11:00:22.15014Z","caller":"traceutil/trace.go:171","msg":"trace[2107340732] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:24519; }","duration":"116.805195ms","start":"2026-05-25T11:00:22.033321Z","end":"2026-05-25T11:00:22.150126Z","steps":["trace[2107340732] 'agreement among raft nodes before linearized reading'  (duration: 115.421039ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:22.300137Z","caller":"traceutil/trace.go:171","msg":"trace[248128761] linearizableReadLoop","detail":"{readStateIndex:25319; appliedIndex:25318; }","duration":"143.871917ms","start":"2026-05-25T11:00:22.156236Z","end":"2026-05-25T11:00:22.300108Z","steps":["trace[248128761] 'read index received'  (duration: 129.068737ms)","trace[248128761] 'applied index is now lower than readState.Index'  (duration: 14.80192ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:22.300293Z","caller":"traceutil/trace.go:171","msg":"trace[2124696221] transaction","detail":"{read_only:false; response_revision:24520; number_of_response:1; }","duration":"144.464479ms","start":"2026-05-25T11:00:22.155789Z","end":"2026-05-25T11:00:22.300254Z","steps":["trace[2124696221] 'process raft request'  (duration: 129.501296ms)","trace[2124696221] 'compare'  (duration: 14.684387ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:22.300409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.146362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:898"}
{"level":"info","ts":"2026-05-25T11:00:22.300453Z","caller":"traceutil/trace.go:171","msg":"trace[1572708530] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:24520; }","duration":"144.228943ms","start":"2026-05-25T11:00:22.156211Z","end":"2026-05-25T11:00:22.30044Z","steps":["trace[1572708530] 'agreement among raft nodes before linearized reading'  (duration: 144.05242ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:22.300503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.426468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9602"}
{"level":"info","ts":"2026-05-25T11:00:22.300588Z","caller":"traceutil/trace.go:171","msg":"trace[135285874] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24520; }","duration":"135.5417ms","start":"2026-05-25T11:00:22.165027Z","end":"2026-05-25T11:00:22.300568Z","steps":["trace[135285874] 'agreement among raft nodes before linearized reading'  (duration: 135.299145ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:22.300599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.808999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1822"}
{"level":"info","ts":"2026-05-25T11:00:22.300721Z","caller":"traceutil/trace.go:171","msg":"trace[1338940832] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:24520; }","duration":"113.960922ms","start":"2026-05-25T11:00:22.186731Z","end":"2026-05-25T11:00:22.300692Z","steps":["trace[1338940832] 'agreement among raft nodes before linearized reading'  (duration: 113.621206ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:22.300858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.889203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-25T11:00:22.300934Z","caller":"traceutil/trace.go:171","msg":"trace[1341219338] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24520; }","duration":"128.979156ms","start":"2026-05-25T11:00:22.171936Z","end":"2026-05-25T11:00:22.300915Z","steps":["trace[1341219338] 'agreement among raft nodes before linearized reading'  (duration: 128.807353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:23.578576Z","caller":"traceutil/trace.go:171","msg":"trace[1717082763] transaction","detail":"{read_only:false; response_revision:24535; number_of_response:1; }","duration":"184.919692ms","start":"2026-05-25T11:00:23.393631Z","end":"2026-05-25T11:00:23.578551Z","steps":["trace[1717082763] 'process raft request'  (duration: 184.753558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:23.585736Z","caller":"traceutil/trace.go:171","msg":"trace[826043342] transaction","detail":"{read_only:false; response_revision:24536; number_of_response:1; }","duration":"191.979736ms","start":"2026-05-25T11:00:23.393736Z","end":"2026-05-25T11:00:23.585716Z","steps":["trace[826043342] 'process raft request'  (duration: 191.808003ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:23.586114Z","caller":"traceutil/trace.go:171","msg":"trace[458928393] transaction","detail":"{read_only:false; response_revision:24537; number_of_response:1; }","duration":"191.470737ms","start":"2026-05-25T11:00:23.394606Z","end":"2026-05-25T11:00:23.586077Z","steps":["trace[458928393] 'process raft request'  (duration: 191.066699ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:23.586196Z","caller":"traceutil/trace.go:171","msg":"trace[1260746099] transaction","detail":"{read_only:false; response_revision:24538; number_of_response:1; }","duration":"189.335976ms","start":"2026-05-25T11:00:23.39682Z","end":"2026-05-25T11:00:23.586156Z","steps":["trace[1260746099] 'process raft request'  (duration: 189.135292ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:23.586162Z","caller":"traceutil/trace.go:171","msg":"trace[981254512] linearizableReadLoop","detail":"{readStateIndex:25338; appliedIndex:25333; }","duration":"186.257288ms","start":"2026-05-25T11:00:23.399881Z","end":"2026-05-25T11:00:23.586138Z","steps":["trace[981254512] 'read index received'  (duration: 178.583073ms)","trace[981254512] 'applied index is now lower than readState.Index'  (duration: 7.672285ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:23.586191Z","caller":"traceutil/trace.go:171","msg":"trace[554215295] transaction","detail":"{read_only:false; response_revision:24539; number_of_response:1; }","duration":"189.175593ms","start":"2026-05-25T11:00:23.39699Z","end":"2026-05-25T11:00:23.586165Z","steps":["trace[554215295] 'process raft request'  (duration: 189.070721ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:23.58641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.490202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-25T11:00:23.586462Z","caller":"traceutil/trace.go:171","msg":"trace[919563968] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24539; }","duration":"186.626984ms","start":"2026-05-25T11:00:23.399818Z","end":"2026-05-25T11:00:23.586445Z","steps":["trace[919563968] 'agreement among raft nodes before linearized reading'  (duration: 186.40476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:23.586607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.640098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-25T11:00:23.586664Z","caller":"traceutil/trace.go:171","msg":"trace[1954512670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24539; }","duration":"183.74038ms","start":"2026-05-25T11:00:23.40291Z","end":"2026-05-25T11:00:23.58665Z","steps":["trace[1954512670] 'agreement among raft nodes before linearized reading'  (duration: 183.535416ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:23.586666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.4046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-25T11:00:23.586709Z","caller":"traceutil/trace.go:171","msg":"trace[328956959] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:24539; }","duration":"159.511793ms","start":"2026-05-25T11:00:23.427185Z","end":"2026-05-25T11:00:23.586696Z","steps":["trace[328956959] 'agreement among raft nodes before linearized reading'  (duration: 159.298899ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:28.580262Z","caller":"traceutil/trace.go:171","msg":"trace[1694155479] linearizableReadLoop","detail":"{readStateIndex:25421; appliedIndex:25420; }","duration":"109.743812ms","start":"2026-05-25T11:00:28.470497Z","end":"2026-05-25T11:00:28.580241Z","steps":["trace[1694155479] 'read index received'  (duration: 109.563729ms)","trace[1694155479] 'applied index is now lower than readState.Index'  (duration: 179.103µs)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:28.580368Z","caller":"traceutil/trace.go:171","msg":"trace[1994689161] transaction","detail":"{read_only:false; response_revision:24620; number_of_response:1; }","duration":"127.362135ms","start":"2026-05-25T11:00:28.452974Z","end":"2026-05-25T11:00:28.580336Z","steps":["trace[1994689161] 'process raft request'  (duration: 127.1081ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:28.580933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.418154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:28.580967Z","caller":"traceutil/trace.go:171","msg":"trace[1132444570] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24620; }","duration":"110.499497ms","start":"2026-05-25T11:00:28.470457Z","end":"2026-05-25T11:00:28.580956Z","steps":["trace[1132444570] 'agreement among raft nodes before linearized reading'  (duration: 109.918027ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:35.873994Z","caller":"traceutil/trace.go:171","msg":"trace[1389542266] transaction","detail":"{read_only:false; response_revision:24673; number_of_response:1; }","duration":"190.217082ms","start":"2026-05-25T11:00:35.683734Z","end":"2026-05-25T11:00:35.873951Z","steps":["trace[1389542266] 'process raft request'  (duration: 184.650157ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:35.874083Z","caller":"traceutil/trace.go:171","msg":"trace[874356305] transaction","detail":"{read_only:false; response_revision:24675; number_of_response:1; }","duration":"179.585281ms","start":"2026-05-25T11:00:35.694486Z","end":"2026-05-25T11:00:35.874071Z","steps":["trace[874356305] 'process raft request'  (duration: 179.350917ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:35.873987Z","caller":"traceutil/trace.go:171","msg":"trace[1406892296] transaction","detail":"{read_only:false; response_revision:24674; number_of_response:1; }","duration":"184.855681ms","start":"2026-05-25T11:00:35.689101Z","end":"2026-05-25T11:00:35.873957Z","steps":["trace[1406892296] 'process raft request'  (duration: 184.615786ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:35.874216Z","caller":"traceutil/trace.go:171","msg":"trace[973241941] transaction","detail":"{read_only:false; response_revision:24676; number_of_response:1; }","duration":"177.908659ms","start":"2026-05-25T11:00:35.696298Z","end":"2026-05-25T11:00:35.874206Z","steps":["trace[973241941] 'process raft request'  (duration: 177.586283ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:35.874764Z","caller":"traceutil/trace.go:171","msg":"trace[541323491] linearizableReadLoop","detail":"{readStateIndex:25480; appliedIndex:25474; }","duration":"174.609207ms","start":"2026-05-25T11:00:35.700132Z","end":"2026-05-25T11:00:35.874742Z","steps":["trace[541323491] 'read index received'  (duration: 37.736302ms)","trace[541323491] 'applied index is now lower than readState.Index'  (duration: 136.871545ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:35.875005Z","caller":"traceutil/trace.go:171","msg":"trace[1848417715] transaction","detail":"{read_only:false; response_revision:24677; number_of_response:1; }","duration":"175.509534ms","start":"2026-05-25T11:00:35.699482Z","end":"2026-05-25T11:00:35.874992Z","steps":["trace[1848417715] 'process raft request'  (duration: 174.767589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:35.875306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.144767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-25T11:00:35.875348Z","caller":"traceutil/trace.go:171","msg":"trace[1297489760] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24677; }","duration":"175.237819ms","start":"2026-05-25T11:00:35.700099Z","end":"2026-05-25T11:00:35.875337Z","steps":["trace[1297489760] 'agreement among raft nodes before linearized reading'  (duration: 175.076576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:35.875649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.723559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-25T11:00:35.87572Z","caller":"traceutil/trace.go:171","msg":"trace[423114020] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24677; }","duration":"174.836701ms","start":"2026-05-25T11:00:35.700866Z","end":"2026-05-25T11:00:35.875703Z","steps":["trace[423114020] 'agreement among raft nodes before linearized reading'  (duration: 174.589236ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:35.875938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.484376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-25T11:00:35.875961Z","caller":"traceutil/trace.go:171","msg":"trace[1472686657] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24677; }","duration":"174.533666ms","start":"2026-05-25T11:00:35.701419Z","end":"2026-05-25T11:00:35.875953Z","steps":["trace[1472686657] 'agreement among raft nodes before linearized reading'  (duration: 174.477325ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:36.067768Z","caller":"traceutil/trace.go:171","msg":"trace[1233541026] transaction","detail":"{read_only:false; response_revision:24678; number_of_response:1; }","duration":"185.127537ms","start":"2026-05-25T11:00:35.882606Z","end":"2026-05-25T11:00:36.067733Z","steps":["trace[1233541026] 'process raft request'  (duration: 123.715757ms)","trace[1233541026] 'compare'  (duration: 61.241716ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:36.151888Z","caller":"traceutil/trace.go:171","msg":"trace[43859796] linearizableReadLoop","detail":"{readStateIndex:25483; appliedIndex:25480; }","duration":"192.505766ms","start":"2026-05-25T11:00:35.959362Z","end":"2026-05-25T11:00:36.151868Z","steps":["trace[43859796] 'read index received'  (duration: 47.061479ms)","trace[43859796] 'applied index is now lower than readState.Index'  (duration: 145.442917ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:36.151981Z","caller":"traceutil/trace.go:171","msg":"trace[1785833101] transaction","detail":"{read_only:false; response_revision:24680; number_of_response:1; }","duration":"269.266026ms","start":"2026-05-25T11:00:35.882678Z","end":"2026-05-25T11:00:36.151944Z","steps":["trace[1785833101] 'process raft request'  (duration: 269.128964ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:36.152122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.72604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-05-25T11:00:36.152154Z","caller":"traceutil/trace.go:171","msg":"trace[549824327] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24680; }","duration":"192.826612ms","start":"2026-05-25T11:00:35.959318Z","end":"2026-05-25T11:00:36.152145Z","steps":["trace[549824327] 'agreement among raft nodes before linearized reading'  (duration: 192.672459ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:36.152217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.334464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:36.152293Z","caller":"traceutil/trace.go:171","msg":"trace[1673204244] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:24680; }","duration":"119.465095ms","start":"2026-05-25T11:00:36.032806Z","end":"2026-05-25T11:00:36.152271Z","steps":["trace[1673204244] 'agreement among raft nodes before linearized reading'  (duration: 119.326823ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:36.152326Z","caller":"traceutil/trace.go:171","msg":"trace[104003526] transaction","detail":"{read_only:false; response_revision:24679; number_of_response:1; }","duration":"269.624663ms","start":"2026-05-25T11:00:35.882682Z","end":"2026-05-25T11:00:36.152306Z","steps":["trace[104003526] 'process raft request'  (duration: 268.921589ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:54.093304Z","caller":"traceutil/trace.go:171","msg":"trace[1608186908] transaction","detail":"{read_only:false; response_revision:24826; number_of_response:1; }","duration":"155.771892ms","start":"2026-05-25T11:00:53.937504Z","end":"2026-05-25T11:00:54.093276Z","steps":["trace[1608186908] 'process raft request'  (duration: 69.585494ms)","trace[1608186908] 'compare'  (duration: 85.877362ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:54.093304Z","caller":"traceutil/trace.go:171","msg":"trace[418551828] transaction","detail":"{read_only:false; response_revision:24827; number_of_response:1; }","duration":"155.508167ms","start":"2026-05-25T11:00:53.937769Z","end":"2026-05-25T11:00:54.093278Z","steps":["trace[418551828] 'process raft request'  (duration: 155.389565ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:54.093409Z","caller":"traceutil/trace.go:171","msg":"trace[1190411772] transaction","detail":"{read_only:false; response_revision:24828; number_of_response:1; }","duration":"153.876516ms","start":"2026-05-25T11:00:53.939501Z","end":"2026-05-25T11:00:54.093378Z","steps":["trace[1190411772] 'process raft request'  (duration: 153.715203ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:54.422211Z","caller":"traceutil/trace.go:171","msg":"trace[459787932] linearizableReadLoop","detail":"{readStateIndex:25638; appliedIndex:25636; }","duration":"140.738188ms","start":"2026-05-25T11:00:54.281451Z","end":"2026-05-25T11:00:54.422189Z","steps":["trace[459787932] 'read index received'  (duration: 43.347349ms)","trace[459787932] 'applied index is now lower than readState.Index'  (duration: 97.389399ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:54.422655Z","caller":"traceutil/trace.go:171","msg":"trace[1302600691] transaction","detail":"{read_only:false; response_revision:24831; number_of_response:1; }","duration":"141.793708ms","start":"2026-05-25T11:00:54.280842Z","end":"2026-05-25T11:00:54.422636Z","steps":["trace[1302600691] 'process raft request'  (duration: 113.83646ms)","trace[1302600691] 'compare'  (duration: 27.378887ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:00:54.422922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.459911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:54.422968Z","caller":"traceutil/trace.go:171","msg":"trace[299723974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24831; }","duration":"141.525222ms","start":"2026-05-25T11:00:54.28143Z","end":"2026-05-25T11:00:54.422956Z","steps":["trace[299723974] 'agreement among raft nodes before linearized reading'  (duration: 141.432441ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:54.911749Z","caller":"traceutil/trace.go:171","msg":"trace[692359596] transaction","detail":"{read_only:false; response_revision:24832; number_of_response:1; }","duration":"204.627374ms","start":"2026-05-25T11:00:54.707096Z","end":"2026-05-25T11:00:54.911724Z","steps":["trace[692359596] 'process raft request'  (duration: 204.44299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:55.011795Z","caller":"traceutil/trace.go:171","msg":"trace[266599347] linearizableReadLoop","detail":"{readStateIndex:25640; appliedIndex:25638; }","duration":"275.149457ms","start":"2026-05-25T11:00:54.736628Z","end":"2026-05-25T11:00:55.011778Z","steps":["trace[266599347] 'read index received'  (duration: 174.835942ms)","trace[266599347] 'applied index is now lower than readState.Index'  (duration: 100.312565ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:55.011976Z","caller":"traceutil/trace.go:171","msg":"trace[1529929660] transaction","detail":"{read_only:false; response_revision:24833; number_of_response:1; }","duration":"302.446062ms","start":"2026-05-25T11:00:54.709506Z","end":"2026-05-25T11:00:55.011952Z","steps":["trace[1529929660] 'process raft request'  (duration: 215.634722ms)","trace[1529929660] 'compare'  (duration: 86.300291ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:55.012073Z","caller":"traceutil/trace.go:171","msg":"trace[1012261274] transaction","detail":"{read_only:false; response_revision:24834; number_of_response:1; }","duration":"122.749109ms","start":"2026-05-25T11:00:54.889263Z","end":"2026-05-25T11:00:55.012012Z","steps":["trace[1012261274] 'process raft request'  (duration: 122.461074ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:55.012104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:54.70949Z","time spent":"302.541853ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24819 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-25T11:00:55.012135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.475293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-25T11:00:55.012257Z","caller":"traceutil/trace.go:171","msg":"trace[1796191489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24834; }","duration":"275.639565ms","start":"2026-05-25T11:00:54.736597Z","end":"2026-05-25T11:00:55.012237Z","steps":["trace[1796191489] 'agreement among raft nodes before linearized reading'  (duration: 275.34235ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:55.012182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.749551ms","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-05-25T11:00:55.012366Z","caller":"traceutil/trace.go:171","msg":"trace[645003050] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:24834; }","duration":"254.965165ms","start":"2026-05-25T11:00:54.757377Z","end":"2026-05-25T11:00:55.012342Z","steps":["trace[645003050] 'agreement among raft nodes before linearized reading'  (duration: 254.633879ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:55.201091Z","caller":"traceutil/trace.go:171","msg":"trace[1912101173] transaction","detail":"{read_only:false; response_revision:24836; number_of_response:1; }","duration":"184.27291ms","start":"2026-05-25T11:00:55.016792Z","end":"2026-05-25T11:00:55.201065Z","steps":["trace[1912101173] 'process raft request'  (duration: 130.468545ms)","trace[1912101173] 'compare'  (duration: 53.561741ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:56.00996Z","caller":"traceutil/trace.go:171","msg":"trace[1679549168] transaction","detail":"{read_only:false; response_revision:24839; number_of_response:1; }","duration":"113.700568ms","start":"2026-05-25T11:00:55.896227Z","end":"2026-05-25T11:00:56.009928Z","steps":["trace[1679549168] 'process raft request'  (duration: 63.899117ms)","trace[1679549168] 'compare'  (duration: 49.510145ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:56.22233Z","caller":"traceutil/trace.go:171","msg":"trace[1256621964] transaction","detail":"{read_only:false; response_revision:24841; number_of_response:1; }","duration":"124.879028ms","start":"2026-05-25T11:00:56.097418Z","end":"2026-05-25T11:00:56.222297Z","steps":["trace[1256621964] 'process raft request'  (duration: 53.596072ms)","trace[1256621964] 'compare'  (duration: 71.139743ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:00:56.267055Z","caller":"traceutil/trace.go:171","msg":"trace[1154951617] transaction","detail":"{read_only:false; response_revision:24842; number_of_response:1; }","duration":"169.207076ms","start":"2026-05-25T11:00:56.097823Z","end":"2026-05-25T11:00:56.26703Z","steps":["trace[1154951617] 'process raft request'  (duration: 169.031823ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:56.267078Z","caller":"traceutil/trace.go:171","msg":"trace[1861014670] transaction","detail":"{read_only:false; response_revision:24843; number_of_response:1; }","duration":"168.224716ms","start":"2026-05-25T11:00:56.098829Z","end":"2026-05-25T11:00:56.267053Z","steps":["trace[1861014670] 'process raft request'  (duration: 168.142785ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:56.435073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.74899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:00:56.43516Z","caller":"traceutil/trace.go:171","msg":"trace[867921840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24844; }","duration":"103.891272ms","start":"2026-05-25T11:00:56.331248Z","end":"2026-05-25T11:00:56.43514Z","steps":["trace[867921840] 'range keys from in-memory index tree'  (duration: 103.640877ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:00:56.435414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.651375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-25T11:00:56.435525Z","caller":"traceutil/trace.go:171","msg":"trace[439817370] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24844; }","duration":"105.841569ms","start":"2026-05-25T11:00:56.329668Z","end":"2026-05-25T11:00:56.435509Z","steps":["trace[439817370] 'range keys from in-memory index tree'  (duration: 105.289158ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:58.599558Z","caller":"traceutil/trace.go:171","msg":"trace[499018800] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"104.760299ms","start":"2026-05-25T11:00:58.494763Z","end":"2026-05-25T11:00:58.599524Z","steps":["trace[499018800] 'process raft request'  (duration: 104.508985ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:00:58.769389Z","caller":"traceutil/trace.go:171","msg":"trace[1884626851] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"165.014535ms","start":"2026-05-25T11:00:58.604343Z","end":"2026-05-25T11:00:58.769357Z","steps":["trace[1884626851] 'process raft request'  (duration: 93.489624ms)","trace[1884626851] 'compare'  (duration: 71.389419ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:01:10.273221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.67556ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854732158543482950 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24938 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-25T11:01:10.273375Z","caller":"traceutil/trace.go:171","msg":"trace[431645585] linearizableReadLoop","detail":"{readStateIndex:25764; appliedIndex:25763; }","duration":"169.800216ms","start":"2026-05-25T11:01:10.103553Z","end":"2026-05-25T11:01:10.273353Z","steps":["trace[431645585] 'read index received'  (duration: 40.710609ms)","trace[431645585] 'applied index is now lower than readState.Index'  (duration: 129.088117ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:01:10.273472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.922839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-25T11:01:10.273511Z","caller":"traceutil/trace.go:171","msg":"trace[2088021789] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24953; }","duration":"170.018921ms","start":"2026-05-25T11:01:10.103478Z","end":"2026-05-25T11:01:10.273497Z","steps":["trace[2088021789] 'agreement among raft nodes before linearized reading'  (duration: 169.93645ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:01:10.273493Z","caller":"traceutil/trace.go:171","msg":"trace[883609633] transaction","detail":"{read_only:false; response_revision:24953; number_of_response:1; }","duration":"218.053128ms","start":"2026-05-25T11:01:10.055408Z","end":"2026-05-25T11:01:10.273462Z","steps":["trace[883609633] 'process raft request'  (duration: 88.92841ms)","trace[883609633] 'compare'  (duration: 128.478846ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-25T11:01:20.344995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.726751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-25T11:01:20.345119Z","caller":"traceutil/trace.go:171","msg":"trace[2145984488] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:25025; }","duration":"218.909424ms","start":"2026-05-25T11:01:20.126194Z","end":"2026-05-25T11:01:20.345104Z","steps":["trace[2145984488] 'count revisions from in-memory index tree'  (duration: 218.623578ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:01:20.495505Z","caller":"traceutil/trace.go:171","msg":"trace[1110054720] transaction","detail":"{read_only:false; response_revision:25027; number_of_response:1; }","duration":"143.342727ms","start":"2026-05-25T11:01:20.352127Z","end":"2026-05-25T11:01:20.495469Z","steps":["trace[1110054720] 'process raft request'  (duration: 133.155854ms)","trace[1110054720] 'compare'  (duration: 10.070971ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:01:20.506588Z","caller":"traceutil/trace.go:171","msg":"trace[520080905] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"113.258049ms","start":"2026-05-25T11:01:20.393313Z","end":"2026-05-25T11:01:20.506571Z","steps":["trace[520080905] 'process raft request'  (duration: 113.177368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:01:20.506601Z","caller":"traceutil/trace.go:171","msg":"trace[1638459345] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"121.608707ms","start":"2026-05-25T11:01:20.38496Z","end":"2026-05-25T11:01:20.506569Z","steps":["trace[1638459345] 'process raft request'  (duration: 121.437633ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:01:20.650134Z","caller":"traceutil/trace.go:171","msg":"trace[936743806] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"137.451716ms","start":"2026-05-25T11:01:20.512656Z","end":"2026-05-25T11:01:20.650108Z","steps":["trace[936743806] 'process raft request'  (duration: 131.805829ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-25T11:01:20.867998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.571278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-25T11:01:20.8681Z","caller":"traceutil/trace.go:171","msg":"trace[1956120134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25030; }","duration":"110.699901ms","start":"2026-05-25T11:01:20.757362Z","end":"2026-05-25T11:01:20.868062Z","steps":["trace[1956120134] 'range keys from in-memory index tree'  (duration: 110.357244ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:01:31.153271Z","caller":"traceutil/trace.go:171","msg":"trace[498340358] transaction","detail":"{read_only:false; response_revision:25106; number_of_response:1; }","duration":"205.853868ms","start":"2026-05-25T11:01:30.947385Z","end":"2026-05-25T11:01:31.153239Z","steps":["trace[498340358] 'process raft request'  (duration: 126.830375ms)","trace[498340358] 'compare'  (duration: 78.87424ms)"],"step_count":2}
{"level":"info","ts":"2026-05-25T11:01:31.154679Z","caller":"traceutil/trace.go:171","msg":"trace[1241433623] transaction","detail":"{read_only:false; response_revision:25107; number_of_response:1; }","duration":"102.937484ms","start":"2026-05-25T11:01:31.051712Z","end":"2026-05-25T11:01:31.154649Z","steps":["trace[1241433623] 'process raft request'  (duration: 102.766581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-25T11:03:06.031083Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006920.wal"}
{"level":"info","ts":"2026-05-25T11:03:30.727282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23351}
{"level":"info","ts":"2026-05-25T11:03:30.865306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23351,"took":"134.643663ms","hash":3824544616,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":37187584,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-05-25T11:03:30.865361Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3824544616,"revision":23351,"compact-revision":20033}
{"level":"info","ts":"2026-05-25T11:08:30.734031Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26282}
{"level":"info","ts":"2026-05-25T11:08:30.880763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26282,"took":"141.960661ms","hash":1161497524,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":33280000,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-25T11:08:30.88084Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1161497524,"revision":26282,"compact-revision":23351}
{"level":"info","ts":"2026-05-25T11:08:57.560073Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1ab0380b9290bdc","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T11:08:57.565805Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-25T11:08:57.56596Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-25T11:13:30.741842Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28887}
{"level":"info","ts":"2026-05-25T11:13:30.882328Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28887,"took":"135.456069ms","hash":3322055710,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":31014912,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-25T11:13:30.882406Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3322055710,"revision":28887,"compact-revision":26282}
{"level":"info","ts":"2026-05-25T11:18:30.750849Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31106}
{"level":"info","ts":"2026-05-25T11:18:30.888561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31106,"took":"133.552885ms","hash":1818213578,"current-db-size-bytes":57778176,"current-db-size":"58 MB","current-db-size-in-use-bytes":32329728,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-25T11:18:30.888648Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1818213578,"revision":31106,"compact-revision":28887}
{"level":"info","ts":"2026-05-25T11:23:30.77413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33375}
{"level":"info","ts":"2026-05-25T11:23:30.929875Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33375,"took":"151.373281ms","hash":2126738855,"current-db-size-bytes":58822656,"current-db-size":"59 MB","current-db-size-in-use-bytes":32075776,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-25T11:23:30.929948Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2126738855,"revision":33375,"compact-revision":31106}
{"level":"info","ts":"2026-05-25T11:28:30.782265Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35668}
{"level":"info","ts":"2026-05-25T11:28:30.934757Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35668,"took":"147.511497ms","hash":3292507408,"current-db-size-bytes":60141568,"current-db-size":"60 MB","current-db-size-in-use-bytes":31899648,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-25T11:28:30.934855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3292507408,"revision":35668,"compact-revision":33375}
{"level":"info","ts":"2026-05-25T11:30:23.771613Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1ab0380b9290bdc","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-25T11:30:23.777284Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-25T11:30:23.777462Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-25T11:33:30.790103Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37893}
{"level":"info","ts":"2026-05-25T11:33:30.930626Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37893,"took":"134.330278ms","hash":3330399946,"current-db-size-bytes":60141568,"current-db-size":"60 MB","current-db-size-in-use-bytes":31391744,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-25T11:33:30.930721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3330399946,"revision":37893,"compact-revision":35668}