{"level":"warn","ts":"2026-07-21T06:43:45.857346Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-21T06:43:45.857458Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-07-21T06:43:45.857531Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-21T06:43:45.857539Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]}
{"level":"info","ts":"2026-07-21T06:43:45.857561Z","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-07-21T06:43:45.858251Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]}
{"level":"info","ts":"2026-07-21T06:43:45.858351Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-07-21T06:43:45.862557Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.976882ms"}
{"level":"info","ts":"2026-07-21T06:43:45.870383Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"}
{"level":"info","ts":"2026-07-21T06:43:45.870513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-21T06:43:45.870544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"}
{"level":"info","ts":"2026-07-21T06:43:45.870562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-21T06:43:45.870581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"}
{"level":"info","ts":"2026-07-21T06:43:45.870641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"}
{"level":"warn","ts":"2026-07-21T06:43:45.876776Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-21T06:43:45.878725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-21T06:43:45.879825Z","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-07-21T06:43:45.884426Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-21T06:43:45.884676Z","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-07-21T06:43:45.884786Z","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-07-21T06:43:45.884806Z","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-07-21T06:43:45.884745Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-21T06:43:45.885731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"}
{"level":"info","ts":"2026-07-21T06:43:45.888312Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]}
{"level":"info","ts":"2026-07-21T06:43:45.89187Z","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-07-21T06:43:45.891974Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"}
{"level":"info","ts":"2026-07-21T06:43:45.89203Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"}
{"level":"info","ts":"2026-07-21T06:43:45.892162Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-21T06:43:45.892202Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-21T06:43:46.071588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-21T06:43:46.071681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-21T06:43:46.071732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"}
{"level":"info","ts":"2026-07-21T06:43:46.071757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"}
{"level":"info","ts":"2026-07-21T06:43:46.071773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"}
{"level":"info","ts":"2026-07-21T06:43:46.071791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"}
{"level":"info","ts":"2026-07-21T06:43:46.071808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"}
{"level":"info","ts":"2026-07-21T06:43:46.073087Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-21T06:43:46.07327Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-21T06:43:46.073384Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-21T06:43:46.073443Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-21T06:43:46.074249Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-21T06:43:46.074334Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-21T06:43:46.07436Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-21T06:43:46.076948Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-21T06:43:46.076996Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-21T06:43:46.077399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"}
{"level":"info","ts":"2026-07-21T06:43:46.077931Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-07-21T06:44:04.594502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.415818ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098499960 > lease_revoke:<id:0e099f836a8c4fe5>","response":"size:28"}
{"level":"info","ts":"2026-07-21T06:44:04.594649Z","caller":"traceutil/trace.go:171","msg":"trace[1744050562] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"123.608298ms","start":"2026-07-21T06:44:04.471018Z","end":"2026-07-21T06:44:04.594626Z","steps":["trace[1744050562] 'read index received'  (duration: 127.032µs)","trace[1744050562] 'applied index is now lower than readState.Index'  (duration: 123.479566ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T06:44:04.594754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.725901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-21T06:44:04.594781Z","caller":"traceutil/trace.go:171","msg":"trace[663548737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:384; }","duration":"124.002016ms","start":"2026-07-21T06:44:04.47077Z","end":"2026-07-21T06:44:04.594772Z","steps":["trace[663548737] 'agreement among raft nodes before linearized reading'  (duration: 123.928625ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:44:10.036425Z","caller":"traceutil/trace.go:171","msg":"trace[103517664] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"166.619626ms","start":"2026-07-21T06:44:09.869766Z","end":"2026-07-21T06:44:10.036385Z","steps":["trace[103517664] 'process raft request'  (duration: 117.62328ms)","trace[103517664] 'compare'  (duration: 48.828013ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T06:44:34.504898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.22226ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098500383 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:604 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036197 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-21T06:44:34.505218Z","caller":"traceutil/trace.go:171","msg":"trace[833019458] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"472.309276ms","start":"2026-07-21T06:44:34.032844Z","end":"2026-07-21T06:44:34.505154Z","steps":["trace[833019458] 'process raft request'  (duration: 275.31958ms)","trace[833019458] 'compare'  (duration: 195.848533ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:44:34.50525Z","caller":"traceutil/trace.go:171","msg":"trace[721638898] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"467.658334ms","start":"2026-07-21T06:44:34.037537Z","end":"2026-07-21T06:44:34.505195Z","steps":["trace[721638898] 'process raft request'  (duration: 467.504951ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:44:34.50546Z","caller":"traceutil/trace.go:171","msg":"trace[681325473] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"342.937574ms","start":"2026-07-21T06:44:34.162319Z","end":"2026-07-21T06:44:34.505257Z","steps":["trace[681325473] 'read index received'  (duration: 142.673014ms)","trace[681325473] 'applied index is now lower than readState.Index'  (duration: 200.24954ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T06:44:34.505594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:44:34.037513Z","time spent":"467.959699ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:591 > 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-07-21T06:44:34.505569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:44:34.032821Z","time spent":"472.598541ms","remote":"127.0.0.1:52426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:604 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036197 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-07-21T06:44:34.516113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.791303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-07-21T06:44:34.516199Z","caller":"traceutil/trace.go:171","msg":"trace[65479314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"303.942796ms","start":"2026-07-21T06:44:34.212238Z","end":"2026-07-21T06:44:34.516181Z","steps":["trace[65479314] 'agreement among raft nodes before linearized reading'  (duration: 303.720972ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:44:34.516189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.84807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-07-21T06:44:34.516244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:44:34.212207Z","time spent":"304.028137ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-21T06:44:34.516496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.087658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-07-21T06:44:34.516611Z","caller":"traceutil/trace.go:171","msg":"trace[2015097883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:608; }","duration":"304.262942ms","start":"2026-07-21T06:44:34.212321Z","end":"2026-07-21T06:44:34.516584Z","steps":["trace[2015097883] 'agreement among raft nodes before linearized reading'  (duration: 303.973126ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:44:34.516691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:44:34.212277Z","time spent":"304.400735ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-21T06:44:34.516846Z","caller":"traceutil/trace.go:171","msg":"trace[1405926664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:608; }","duration":"354.016214ms","start":"2026-07-21T06:44:34.162245Z","end":"2026-07-21T06:44:34.516261Z","steps":["trace[1405926664] 'agreement among raft nodes before linearized reading'  (duration: 343.125088ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:44:34.516912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:44:34.162185Z","time spent":"354.712847ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-21T06:45:18.865084Z","caller":"traceutil/trace.go:171","msg":"trace[625184608] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"110.313164ms","start":"2026-07-21T06:45:18.754741Z","end":"2026-07-21T06:45:18.865055Z","steps":["trace[625184608] 'process raft request'  (duration: 109.996548ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:45:18.865093Z","caller":"traceutil/trace.go:171","msg":"trace[148800262] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"109.228251ms","start":"2026-07-21T06:45:18.755832Z","end":"2026-07-21T06:45:18.865061Z","steps":["trace[148800262] 'process raft request'  (duration: 109.076828ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:45:18.865856Z","caller":"traceutil/trace.go:171","msg":"trace[778585278] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"108.882244ms","start":"2026-07-21T06:45:18.756377Z","end":"2026-07-21T06:45:18.86526Z","steps":["trace[778585278] 'process raft request'  (duration: 108.632819ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:46:03.765261Z","caller":"traceutil/trace.go:171","msg":"trace[394546331] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"293.690155ms","start":"2026-07-21T06:46:03.471533Z","end":"2026-07-21T06:46:03.765223Z","steps":["trace[394546331] 'process raft request'  (duration: 293.46686ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:46:03.812702Z","caller":"traceutil/trace.go:171","msg":"trace[2390790] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1899; }","duration":"222.495594ms","start":"2026-07-21T06:46:03.590181Z","end":"2026-07-21T06:46:03.812677Z","steps":["trace[2390790] 'read index received'  (duration: 174.800062ms)","trace[2390790] 'applied index is now lower than readState.Index'  (duration: 47.694452ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:46:03.812841Z","caller":"traceutil/trace.go:171","msg":"trace[1125016988] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"318.162564ms","start":"2026-07-21T06:46:03.494601Z","end":"2026-07-21T06:46:03.812763Z","steps":["trace[1125016988] 'process raft request'  (duration: 317.940049ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:46:03.812923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.723049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-07-21T06:46:03.81297Z","caller":"traceutil/trace.go:171","msg":"trace[1399930975] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1828; }","duration":"222.838711ms","start":"2026-07-21T06:46:03.590116Z","end":"2026-07-21T06:46:03.812954Z","steps":["trace[1399930975] 'agreement among raft nodes before linearized reading'  (duration: 222.663167ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:46:03.81312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:46:03.494579Z","time spent":"318.397239ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1759 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-21T06:46:54.193034Z","caller":"traceutil/trace.go:171","msg":"trace[1235592537] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"122.871328ms","start":"2026-07-21T06:46:54.070126Z","end":"2026-07-21T06:46:54.192998Z","steps":["trace[1235592537] 'process raft request'  (duration: 122.679384ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:47:47.493641Z","caller":"traceutil/trace.go:171","msg":"trace[993749049] transaction","detail":"{read_only:false; response_revision:2614; number_of_response:1; }","duration":"134.354882ms","start":"2026-07-21T06:47:47.359249Z","end":"2026-07-21T06:47:47.493604Z","steps":["trace[993749049] 'process raft request'  (duration: 134.070565ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:48:21.962249Z","caller":"traceutil/trace.go:171","msg":"trace[1340138586] linearizableReadLoop","detail":"{readStateIndex:2933; appliedIndex:2932; }","duration":"171.594977ms","start":"2026-07-21T06:48:21.790598Z","end":"2026-07-21T06:48:21.962193Z","steps":["trace[1340138586] 'read index received'  (duration: 152.761894ms)","trace[1340138586] 'applied index is now lower than readState.Index'  (duration: 18.832053ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:48:21.962304Z","caller":"traceutil/trace.go:171","msg":"trace[776530334] transaction","detail":"{read_only:false; response_revision:2822; number_of_response:1; }","duration":"252.886384ms","start":"2026-07-21T06:48:21.709378Z","end":"2026-07-21T06:48:21.962265Z","steps":["trace[776530334] 'process raft request'  (duration: 234.085102ms)","trace[776530334] 'compare'  (duration: 18.604889ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T06:48:21.962539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.923114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-21T06:48:21.962631Z","caller":"traceutil/trace.go:171","msg":"trace[1244241657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2822; }","duration":"172.091977ms","start":"2026-07-21T06:48:21.790518Z","end":"2026-07-21T06:48:21.96261Z","steps":["trace[1244241657] 'agreement among raft nodes before linearized reading'  (duration: 171.812722ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:48:22.006326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.393549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-07-21T06:48:22.006327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.420829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-07-21T06:48:22.006378Z","caller":"traceutil/trace.go:171","msg":"trace[311959619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2823; }","duration":"189.4915ms","start":"2026-07-21T06:48:21.816874Z","end":"2026-07-21T06:48:22.006365Z","steps":["trace[311959619] 'agreement among raft nodes before linearized reading'  (duration: 189.306847ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:48:22.006316Z","caller":"traceutil/trace.go:171","msg":"trace[1857939517] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"191.173914ms","start":"2026-07-21T06:48:21.815001Z","end":"2026-07-21T06:48:22.006175Z","steps":["trace[1857939517] 'process raft request'  (duration: 190.96036ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:48:22.006394Z","caller":"traceutil/trace.go:171","msg":"trace[28755123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2823; }","duration":"189.530943ms","start":"2026-07-21T06:48:21.816847Z","end":"2026-07-21T06:48:22.006378Z","steps":["trace[28755123] 'agreement among raft nodes before linearized reading'  (duration: 189.237146ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:52:23.209533Z","caller":"traceutil/trace.go:171","msg":"trace[380560720] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"126.857461ms","start":"2026-07-21T06:52:23.082613Z","end":"2026-07-21T06:52:23.20947Z","steps":["trace[380560720] 'process raft request'  (duration: 126.421132ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:52:28.714671Z","caller":"traceutil/trace.go:171","msg":"trace[845256743] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"118.657063ms","start":"2026-07-21T06:52:28.595979Z","end":"2026-07-21T06:52:28.714636Z","steps":["trace[845256743] 'process raft request'  (duration: 118.436079ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:52:41.004199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.281189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-21T06:52:41.004301Z","caller":"traceutil/trace.go:171","msg":"trace[1267401345] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:5311; }","duration":"447.400212ms","start":"2026-07-21T06:52:40.556876Z","end":"2026-07-21T06:52:41.004277Z","steps":["trace[1267401345] 'count revisions from in-memory index tree'  (duration: 447.172897ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:52:41.004347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T06:52:40.556802Z","time spent":"447.533224ms","remote":"127.0.0.1:51378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":31,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"warn","ts":"2026-07-21T06:52:41.004428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.119879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-ds7bd\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-07-21T06:52:41.004606Z","caller":"traceutil/trace.go:171","msg":"trace[1926572042] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-ds7bd; range_end:; response_count:1; response_revision:5311; }","duration":"284.340714ms","start":"2026-07-21T06:52:40.72024Z","end":"2026-07-21T06:52:41.004581Z","steps":["trace[1926572042] 'range keys from in-memory index tree'  (duration: 283.746582ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:52:49.178183Z","caller":"traceutil/trace.go:171","msg":"trace[992999571] transaction","detail":"{read_only:false; response_revision:5520; number_of_response:1; }","duration":"149.418534ms","start":"2026-07-21T06:52:49.028707Z","end":"2026-07-21T06:52:49.178125Z","steps":["trace[992999571] 'process raft request'  (duration: 75.801128ms)","trace[992999571] 'compare'  (duration: 73.275338ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T06:52:59.12206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.409026ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098511992 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:5558 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-21T06:52:59.12237Z","caller":"traceutil/trace.go:171","msg":"trace[695807099] transaction","detail":"{read_only:false; response_revision:5629; number_of_response:1; }","duration":"121.07409ms","start":"2026-07-21T06:52:59.001236Z","end":"2026-07-21T06:52:59.122311Z","steps":["trace[695807099] 'process raft request'  (duration: 18.306747ms)","trace[695807099] 'compare'  (duration: 102.236943ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:53:46.134731Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2956}
{"level":"info","ts":"2026-07-21T06:53:46.209206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2956,"took":"72.647266ms","hash":2013512886,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":33509376,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-21T06:53:46.209281Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2013512886,"revision":2956,"compact-revision":-1}
{"level":"info","ts":"2026-07-21T06:58:46.147441Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6017}
{"level":"info","ts":"2026-07-21T06:58:46.251133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6017,"took":"101.522069ms","hash":565312237,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":23871488,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-07-21T06:58:46.251199Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":565312237,"revision":6017,"compact-revision":2956}
{"level":"info","ts":"2026-07-21T06:58:59.492676Z","caller":"traceutil/trace.go:171","msg":"trace[549782147] transaction","detail":"{read_only:false; response_revision:8330; number_of_response:1; }","duration":"132.577963ms","start":"2026-07-21T06:58:59.360062Z","end":"2026-07-21T06:58:59.49264Z","steps":["trace[549782147] 'process raft request'  (duration: 96.989594ms)","trace[549782147] 'compare'  (duration: 35.419155ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:58:59.550686Z","caller":"traceutil/trace.go:171","msg":"trace[1974340647] transaction","detail":"{read_only:false; response_revision:8331; number_of_response:1; }","duration":"144.036518ms","start":"2026-07-21T06:58:59.406623Z","end":"2026-07-21T06:58:59.550659Z","steps":["trace[1974340647] 'process raft request'  (duration: 143.807133ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:58:59.550855Z","caller":"traceutil/trace.go:171","msg":"trace[1223716817] transaction","detail":"{read_only:false; response_revision:8332; number_of_response:1; }","duration":"103.312702ms","start":"2026-07-21T06:58:59.447493Z","end":"2026-07-21T06:58:59.550805Z","steps":["trace[1223716817] 'process raft request'  (duration: 103.108179ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:59:27.026496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.233369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4fppf\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-07-21T06:59:27.026584Z","caller":"traceutil/trace.go:171","msg":"trace[1409163869] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4fppf; range_end:; response_count:1; response_revision:8529; }","duration":"222.374092ms","start":"2026-07-21T06:59:26.80419Z","end":"2026-07-21T06:59:27.026564Z","steps":["trace[1409163869] 'range keys from in-memory index tree'  (duration: 222.060816ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:28.859637Z","caller":"traceutil/trace.go:171","msg":"trace[754035784] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"134.673451ms","start":"2026-07-21T06:59:28.724928Z","end":"2026-07-21T06:59:28.859602Z","steps":["trace[754035784] 'process raft request'  (duration: 134.485987ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:39.813892Z","caller":"traceutil/trace.go:171","msg":"trace[1285330121] transaction","detail":"{read_only:false; response_revision:8640; number_of_response:1; }","duration":"124.768627ms","start":"2026-07-21T06:59:39.689081Z","end":"2026-07-21T06:59:39.813849Z","steps":["trace[1285330121] 'process raft request'  (duration: 124.514792ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:39.828593Z","caller":"traceutil/trace.go:171","msg":"trace[1436900466] transaction","detail":"{read_only:false; response_revision:8641; number_of_response:1; }","duration":"127.937676ms","start":"2026-07-21T06:59:39.700624Z","end":"2026-07-21T06:59:39.828562Z","steps":["trace[1436900466] 'process raft request'  (duration: 127.753493ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:39.96742Z","caller":"traceutil/trace.go:171","msg":"trace[721577807] transaction","detail":"{read_only:false; response_revision:8642; number_of_response:1; }","duration":"108.220156ms","start":"2026-07-21T06:59:39.85915Z","end":"2026-07-21T06:59:39.96737Z","steps":["trace[721577807] 'process raft request'  (duration: 31.172376ms)","trace[721577807] 'compare'  (duration: 76.819845ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:59:39.96742Z","caller":"traceutil/trace.go:171","msg":"trace[475172480] linearizableReadLoop","detail":"{readStateIndex:8948; appliedIndex:8947; }","duration":"107.712406ms","start":"2026-07-21T06:59:39.859661Z","end":"2026-07-21T06:59:39.967373Z","steps":["trace[475172480] 'read index received'  (duration: 30.671377ms)","trace[475172480] 'applied index is now lower than readState.Index'  (duration: 77.038019ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:59:39.967435Z","caller":"traceutil/trace.go:171","msg":"trace[1671646347] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"104.708879ms","start":"2026-07-21T06:59:39.862696Z","end":"2026-07-21T06:59:39.967405Z","steps":["trace[1671646347] 'process raft request'  (duration: 104.604557ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:39.967612Z","caller":"traceutil/trace.go:171","msg":"trace[198940674] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"104.383494ms","start":"2026-07-21T06:59:39.863154Z","end":"2026-07-21T06:59:39.967537Z","steps":["trace[198940674] 'process raft request'  (duration: 104.19791ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:59:39.96777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.080262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-07-21T06:59:39.967846Z","caller":"traceutil/trace.go:171","msg":"trace[924570998] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8644; }","duration":"108.223135ms","start":"2026-07-21T06:59:39.859606Z","end":"2026-07-21T06:59:39.967829Z","steps":["trace[924570998] 'agreement among raft nodes before linearized reading'  (duration: 107.96087ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:41.004517Z","caller":"traceutil/trace.go:171","msg":"trace[928513448] linearizableReadLoop","detail":"{readStateIndex:8956; appliedIndex:8955; }","duration":"104.376032ms","start":"2026-07-21T06:59:40.900122Z","end":"2026-07-21T06:59:41.004498Z","steps":["trace[928513448] 'read index received'  (duration: 104.196489ms)","trace[928513448] 'applied index is now lower than readState.Index'  (duration: 178.883µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T06:59:41.004656Z","caller":"traceutil/trace.go:171","msg":"trace[381076459] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"106.601894ms","start":"2026-07-21T06:59:40.897883Z","end":"2026-07-21T06:59:41.004602Z","steps":["trace[381076459] 'process raft request'  (duration: 106.37422ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T06:59:41.004732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.603576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-07-21T06:59:41.004785Z","caller":"traceutil/trace.go:171","msg":"trace[244647844] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:8650; }","duration":"104.712289ms","start":"2026-07-21T06:59:40.900058Z","end":"2026-07-21T06:59:41.004771Z","steps":["trace[244647844] 'agreement among raft nodes before linearized reading'  (duration: 104.516535ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T06:59:52.505219Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000235e.wal"}
{"level":"info","ts":"2026-07-21T07:01:32.547942Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fed19d9291630e09","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-21T07:01:32.554041Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-21T07:01:32.554133Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-21T07:03:46.153811Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8262}
{"level":"info","ts":"2026-07-21T07:03:46.236991Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8262,"took":"77.492339ms","hash":1378905691,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":26320896,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-07-21T07:03:46.237055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1378905691,"revision":8262,"compact-revision":6017}
{"level":"warn","ts":"2026-07-21T07:04:37.623307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.591786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-07-21T07:04:37.623345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.822848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-21T07:04:37.62341Z","caller":"traceutil/trace.go:171","msg":"trace[1500642055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11227; }","duration":"132.742598ms","start":"2026-07-21T07:04:37.490647Z","end":"2026-07-21T07:04:37.623389Z","steps":["trace[1500642055] 'range keys from in-memory index tree'  (duration: 132.399862ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:04:37.623437Z","caller":"traceutil/trace.go:171","msg":"trace[466528509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11227; }","duration":"133.984631ms","start":"2026-07-21T07:04:37.48943Z","end":"2026-07-21T07:04:37.623415Z","steps":["trace[466528509] 'range keys from in-memory index tree'  (duration: 133.614535ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:04:37.623469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.906161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-21T07:04:37.623558Z","caller":"traceutil/trace.go:171","msg":"trace[112778625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11227; }","duration":"133.066545ms","start":"2026-07-21T07:04:37.490469Z","end":"2026-07-21T07:04:37.623536Z","steps":["trace[112778625] 'range keys from in-memory index tree'  (duration: 132.711878ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:04:37.904467Z","caller":"traceutil/trace.go:171","msg":"trace[1257977863] transaction","detail":"{read_only:false; response_revision:11230; number_of_response:1; }","duration":"275.582277ms","start":"2026-07-21T07:04:37.628839Z","end":"2026-07-21T07:04:37.904422Z","steps":["trace[1257977863] 'process raft request'  (duration: 275.18514ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:04:37.904671Z","caller":"traceutil/trace.go:171","msg":"trace[376786722] transaction","detail":"{read_only:false; response_revision:11229; number_of_response:1; }","duration":"276.658828ms","start":"2026-07-21T07:04:37.627993Z","end":"2026-07-21T07:04:37.904651Z","steps":["trace[376786722] 'process raft request'  (duration: 268.655586ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:08:46.160566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10750}
{"level":"info","ts":"2026-07-21T07:08:46.24421Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10750,"took":"79.862451ms","hash":1681406758,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":27365376,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-07-21T07:08:46.244293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1681406758,"revision":10750,"compact-revision":8262}
{"level":"info","ts":"2026-07-21T07:11:02.561529Z","caller":"traceutil/trace.go:171","msg":"trace[426304222] transaction","detail":"{read_only:false; response_revision:13856; number_of_response:1; }","duration":"189.269747ms","start":"2026-07-21T07:11:02.372231Z","end":"2026-07-21T07:11:02.561501Z","steps":["trace[426304222] 'process raft request'  (duration: 189.083223ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:11:02.579818Z","caller":"traceutil/trace.go:171","msg":"trace[2037841544] linearizableReadLoop","detail":"{readStateIndex:14327; appliedIndex:14325; }","duration":"147.598098ms","start":"2026-07-21T07:11:02.432191Z","end":"2026-07-21T07:11:02.579789Z","steps":["trace[2037841544] 'read index received'  (duration: 129.161985ms)","trace[2037841544] 'applied index is now lower than readState.Index'  (duration: 18.435183ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:11:02.579853Z","caller":"traceutil/trace.go:171","msg":"trace[1866248378] transaction","detail":"{read_only:false; response_revision:13857; number_of_response:1; }","duration":"192.797065ms","start":"2026-07-21T07:11:02.387035Z","end":"2026-07-21T07:11:02.579832Z","steps":["trace[1866248378] 'process raft request'  (duration: 192.589641ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:11:02.580122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.907723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4fppf\" ","response":"range_response_count:1 size:6526"}
{"level":"warn","ts":"2026-07-21T07:11:02.580266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.092219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-21T07:11:02.581119Z","caller":"traceutil/trace.go:171","msg":"trace[445784116] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4fppf; range_end:; response_count:1; response_revision:13857; }","duration":"148.955035ms","start":"2026-07-21T07:11:02.43212Z","end":"2026-07-21T07:11:02.581076Z","steps":["trace[445784116] 'agreement among raft nodes before linearized reading'  (duration: 147.774472ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:11:02.581211Z","caller":"traceutil/trace.go:171","msg":"trace[709010313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13857; }","duration":"111.071029ms","start":"2026-07-21T07:11:02.470107Z","end":"2026-07-21T07:11:02.581178Z","steps":["trace[709010313] 'agreement among raft nodes before linearized reading'  (duration: 110.073159ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:11:03.331426Z","caller":"traceutil/trace.go:171","msg":"trace[2059215870] transaction","detail":"{read_only:false; response_revision:13858; number_of_response:1; }","duration":"140.821889ms","start":"2026-07-21T07:11:03.190579Z","end":"2026-07-21T07:11:03.331401Z","steps":["trace[2059215870] 'process raft request'  (duration: 140.175116ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:12:50.736884Z","caller":"traceutil/trace.go:171","msg":"trace[630044240] linearizableReadLoop","detail":"{readStateIndex:15475; appliedIndex:15473; }","duration":"167.73956ms","start":"2026-07-21T07:12:50.56912Z","end":"2026-07-21T07:12:50.73686Z","steps":["trace[630044240] 'read index received'  (duration: 100.174533ms)","trace[630044240] 'applied index is now lower than readState.Index'  (duration: 67.564127ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:12:50.737183Z","caller":"traceutil/trace.go:171","msg":"trace[650763263] transaction","detail":"{read_only:false; response_revision:14970; number_of_response:1; }","duration":"189.375855ms","start":"2026-07-21T07:12:50.547793Z","end":"2026-07-21T07:12:50.737169Z","steps":["trace[650763263] 'process raft request'  (duration: 121.419581ms)","trace[650763263] 'compare'  (duration: 67.299421ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:12:50.737676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.438332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-07-21T07:12:50.737757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.007304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-21T07:12:50.737775Z","caller":"traceutil/trace.go:171","msg":"trace[1368374249] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14971; }","duration":"168.583276ms","start":"2026-07-21T07:12:50.56917Z","end":"2026-07-21T07:12:50.737753Z","steps":["trace[1368374249] 'agreement among raft nodes before linearized reading'  (duration: 168.089116ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:12:50.7378Z","caller":"traceutil/trace.go:171","msg":"trace[1662971285] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14971; }","duration":"168.078995ms","start":"2026-07-21T07:12:50.569708Z","end":"2026-07-21T07:12:50.737787Z","steps":["trace[1662971285] 'agreement among raft nodes before linearized reading'  (duration: 167.998324ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:12:50.737683Z","caller":"traceutil/trace.go:171","msg":"trace[1604934176] transaction","detail":"{read_only:false; response_revision:14971; number_of_response:1; }","duration":"189.648388ms","start":"2026-07-21T07:12:50.547993Z","end":"2026-07-21T07:12:50.737641Z","steps":["trace[1604934176] 'process raft request'  (duration: 188.816383ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:12:50.738013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.658047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-07-21T07:12:50.738464Z","caller":"traceutil/trace.go:171","msg":"trace[944734201] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14971; }","duration":"168.991503ms","start":"2026-07-21T07:12:50.56909Z","end":"2026-07-21T07:12:50.738082Z","steps":["trace[944734201] 'agreement among raft nodes before linearized reading'  (duration: 168.221168ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:12:50.738557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.659548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-07-21T07:12:50.738633Z","caller":"traceutil/trace.go:171","msg":"trace[1026056858] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14971; }","duration":"142.75743ms","start":"2026-07-21T07:12:50.595856Z","end":"2026-07-21T07:12:50.738614Z","steps":["trace[1026056858] 'agreement among raft nodes before linearized reading'  (duration: 141.457424ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:13:46.16983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12859}
{"level":"info","ts":"2026-07-21T07:13:46.257703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12859,"took":"85.406109ms","hash":798787067,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":30580736,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-21T07:13:46.257759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":798787067,"revision":12859,"compact-revision":10750}
{"level":"info","ts":"2026-07-21T07:18:31.723808Z","caller":"traceutil/trace.go:171","msg":"trace[2035118421] linearizableReadLoop","detail":"{readStateIndex:18108; appliedIndex:18107; }","duration":"119.835492ms","start":"2026-07-21T07:18:31.60394Z","end":"2026-07-21T07:18:31.723776Z","steps":["trace[2035118421] 'read index received'  (duration: 119.548617ms)","trace[2035118421] 'applied index is now lower than readState.Index'  (duration: 285.545µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:31.72396Z","caller":"traceutil/trace.go:171","msg":"trace[977089414] transaction","detail":"{read_only:false; response_revision:17520; number_of_response:1; }","duration":"122.917652ms","start":"2026-07-21T07:18:31.600994Z","end":"2026-07-21T07:18:31.723912Z","steps":["trace[977089414] 'process raft request'  (duration: 122.573256ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:31.724074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.115338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vrqt2\" ","response":"range_response_count:1 size:22129"}
{"level":"info","ts":"2026-07-21T07:18:31.724114Z","caller":"traceutil/trace.go:171","msg":"trace[1133222764] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vrqt2; range_end:; response_count:1; response_revision:17520; }","duration":"120.231401ms","start":"2026-07-21T07:18:31.603872Z","end":"2026-07-21T07:18:31.724103Z","steps":["trace[1133222764] 'agreement among raft nodes before linearized reading'  (duration: 120.029657ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:32.142337Z","caller":"traceutil/trace.go:171","msg":"trace[1957152753] linearizableReadLoop","detail":"{readStateIndex:18109; appliedIndex:18108; }","duration":"127.369896ms","start":"2026-07-21T07:18:32.014936Z","end":"2026-07-21T07:18:32.142306Z","steps":["trace[1957152753] 'read index received'  (duration: 127.080071ms)","trace[1957152753] 'applied index is now lower than readState.Index'  (duration: 288.865µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:32.142509Z","caller":"traceutil/trace.go:171","msg":"trace[1097627438] transaction","detail":"{read_only:false; response_revision:17521; number_of_response:1; }","duration":"151.383636ms","start":"2026-07-21T07:18:31.991054Z","end":"2026-07-21T07:18:32.142437Z","steps":["trace[1097627438] 'process raft request'  (duration: 151.06684ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:32.142626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.658391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:18:32.142752Z","caller":"traceutil/trace.go:171","msg":"trace[76085022] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:17521; }","duration":"127.877125ms","start":"2026-07-21T07:18:32.014843Z","end":"2026-07-21T07:18:32.14272Z","steps":["trace[76085022] 'agreement among raft nodes before linearized reading'  (duration: 127.6189ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:32.700063Z","caller":"traceutil/trace.go:171","msg":"trace[508517103] linearizableReadLoop","detail":"{readStateIndex:18111; appliedIndex:18110; }","duration":"230.616292ms","start":"2026-07-21T07:18:32.469415Z","end":"2026-07-21T07:18:32.700031Z","steps":["trace[508517103] 'read index received'  (duration: 230.359897ms)","trace[508517103] 'applied index is now lower than readState.Index'  (duration: 255.555µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:32.700441Z","caller":"traceutil/trace.go:171","msg":"trace[1210275964] transaction","detail":"{read_only:false; response_revision:17523; number_of_response:1; }","duration":"307.754917ms","start":"2026-07-21T07:18:32.392675Z","end":"2026-07-21T07:18:32.70043Z","steps":["trace[1210275964] 'process raft request'  (duration: 307.181276ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:32.700576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:18:32.392635Z","time spent":"307.840009ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:17508 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-21T07:18:32.701158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.185956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-21T07:18:32.701423Z","caller":"traceutil/trace.go:171","msg":"trace[175238807] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:17523; }","duration":"216.351379ms","start":"2026-07-21T07:18:32.48489Z","end":"2026-07-21T07:18:32.701241Z","steps":["trace[175238807] 'agreement among raft nodes before linearized reading'  (duration: 216.178656ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:32.702139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.642829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-21T07:18:32.702198Z","caller":"traceutil/trace.go:171","msg":"trace[118733575] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:17523; }","duration":"119.71399ms","start":"2026-07-21T07:18:32.582471Z","end":"2026-07-21T07:18:32.702185Z","steps":["trace[118733575] 'agreement among raft nodes before linearized reading'  (duration: 119.604528ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:32.702652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.247742ms","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-07-21T07:18:32.702701Z","caller":"traceutil/trace.go:171","msg":"trace[576448760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17523; }","duration":"233.355364ms","start":"2026-07-21T07:18:32.469335Z","end":"2026-07-21T07:18:32.70269Z","steps":["trace[576448760] 'agreement among raft nodes before linearized reading'  (duration: 231.57654ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:32.870834Z","caller":"traceutil/trace.go:171","msg":"trace[1964099171] transaction","detail":"{read_only:false; response_revision:17524; number_of_response:1; }","duration":"163.956166ms","start":"2026-07-21T07:18:32.706838Z","end":"2026-07-21T07:18:32.870795Z","steps":["trace[1964099171] 'process raft request'  (duration: 131.71297ms)","trace[1964099171] 'compare'  (duration: 31.90063ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:32.875793Z","caller":"traceutil/trace.go:171","msg":"trace[2008507036] transaction","detail":"{read_only:false; response_revision:17525; number_of_response:1; }","duration":"168.82908ms","start":"2026-07-21T07:18:32.706937Z","end":"2026-07-21T07:18:32.875766Z","steps":["trace[2008507036] 'process raft request'  (duration: 168.620736ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:32.876023Z","caller":"traceutil/trace.go:171","msg":"trace[1682449011] linearizableReadLoop","detail":"{readStateIndex:18114; appliedIndex:18111; }","duration":"131.901274ms","start":"2026-07-21T07:18:32.744076Z","end":"2026-07-21T07:18:32.875977Z","steps":["trace[1682449011] 'read index received'  (duration: 94.59278ms)","trace[1682449011] 'applied index is now lower than readState.Index'  (duration: 37.306183ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:32.876077Z","caller":"traceutil/trace.go:171","msg":"trace[1123070868] transaction","detail":"{read_only:false; response_revision:17526; number_of_response:1; }","duration":"168.550744ms","start":"2026-07-21T07:18:32.70745Z","end":"2026-07-21T07:18:32.876001Z","steps":["trace[1123070868] 'process raft request'  (duration: 168.277139ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:32.876345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.23561ms","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-07-21T07:18:32.876469Z","caller":"traceutil/trace.go:171","msg":"trace[1893905388] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17526; }","duration":"132.374262ms","start":"2026-07-21T07:18:32.74406Z","end":"2026-07-21T07:18:32.876434Z","steps":["trace[1893905388] 'agreement among raft nodes before linearized reading'  (duration: 132.055846ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.840636Z","caller":"traceutil/trace.go:171","msg":"trace[1514195493] transaction","detail":"{read_only:false; response_revision:17686; number_of_response:1; }","duration":"112.36194ms","start":"2026-07-21T07:18:40.728242Z","end":"2026-07-21T07:18:40.840604Z","steps":["trace[1514195493] 'process raft request'  (duration: 112.300519ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.840697Z","caller":"traceutil/trace.go:171","msg":"trace[1635059639] transaction","detail":"{read_only:false; response_revision:17685; number_of_response:1; }","duration":"117.006059ms","start":"2026-07-21T07:18:40.723652Z","end":"2026-07-21T07:18:40.840658Z","steps":["trace[1635059639] 'process raft request'  (duration: 116.699113ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.873661Z","caller":"traceutil/trace.go:171","msg":"trace[432892689] linearizableReadLoop","detail":"{readStateIndex:18280; appliedIndex:18277; }","duration":"135.39507ms","start":"2026-07-21T07:18:40.738239Z","end":"2026-07-21T07:18:40.873634Z","steps":["trace[432892689] 'read index received'  (duration: 102.256856ms)","trace[432892689] 'applied index is now lower than readState.Index'  (duration: 33.136574ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:40.873783Z","caller":"traceutil/trace.go:171","msg":"trace[651362859] transaction","detail":"{read_only:false; response_revision:17687; number_of_response:1; }","duration":"139.742364ms","start":"2026-07-21T07:18:40.733989Z","end":"2026-07-21T07:18:40.873731Z","steps":["trace[651362859] 'process raft request'  (duration: 139.273195ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.873784Z","caller":"traceutil/trace.go:171","msg":"trace[1668370113] transaction","detail":"{read_only:false; response_revision:17688; number_of_response:1; }","duration":"132.615657ms","start":"2026-07-21T07:18:40.741121Z","end":"2026-07-21T07:18:40.873737Z","steps":["trace[1668370113] 'process raft request'  (duration: 132.359472ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:40.873974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.725635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1286"}
{"level":"info","ts":"2026-07-21T07:18:40.874032Z","caller":"traceutil/trace.go:171","msg":"trace[619780805] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:17688; }","duration":"135.826458ms","start":"2026-07-21T07:18:40.73819Z","end":"2026-07-21T07:18:40.874016Z","steps":["trace[619780805] 'agreement among raft nodes before linearized reading'  (duration: 135.591564ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.974285Z","caller":"traceutil/trace.go:171","msg":"trace[1611368996] transaction","detail":"{read_only:false; response_revision:17689; number_of_response:1; }","duration":"126.483399ms","start":"2026-07-21T07:18:40.847751Z","end":"2026-07-21T07:18:40.974234Z","steps":["trace[1611368996] 'process raft request'  (duration: 126.163513ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.974427Z","caller":"traceutil/trace.go:171","msg":"trace[931337089] linearizableReadLoop","detail":"{readStateIndex:18288; appliedIndex:18281; }","duration":"100.654535ms","start":"2026-07-21T07:18:40.87375Z","end":"2026-07-21T07:18:40.974404Z","steps":["trace[931337089] 'read index received'  (duration: 100.095875ms)","trace[931337089] 'applied index is now lower than readState.Index'  (duration: 557.44µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:40.974568Z","caller":"traceutil/trace.go:171","msg":"trace[847300791] transaction","detail":"{read_only:false; response_revision:17690; number_of_response:1; }","duration":"126.675943ms","start":"2026-07-21T07:18:40.84788Z","end":"2026-07-21T07:18:40.974556Z","steps":["trace[847300791] 'process raft request'  (duration: 126.198144ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.974721Z","caller":"traceutil/trace.go:171","msg":"trace[907106737] transaction","detail":"{read_only:false; response_revision:17695; number_of_response:1; }","duration":"119.73379ms","start":"2026-07-21T07:18:40.854975Z","end":"2026-07-21T07:18:40.974709Z","steps":["trace[907106737] 'process raft request'  (duration: 119.349583ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.974803Z","caller":"traceutil/trace.go:171","msg":"trace[896024284] transaction","detail":"{read_only:false; response_revision:17691; number_of_response:1; }","duration":"126.662272ms","start":"2026-07-21T07:18:40.848104Z","end":"2026-07-21T07:18:40.974766Z","steps":["trace[896024284] 'process raft request'  (duration: 126.02895ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.974994Z","caller":"traceutil/trace.go:171","msg":"trace[1686431147] transaction","detail":"{read_only:false; response_revision:17692; number_of_response:1; }","duration":"126.839676ms","start":"2026-07-21T07:18:40.848146Z","end":"2026-07-21T07:18:40.974986Z","steps":["trace[1686431147] 'process raft request'  (duration: 126.030811ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.975066Z","caller":"traceutil/trace.go:171","msg":"trace[296691733] transaction","detail":"{read_only:false; response_revision:17693; number_of_response:1; }","duration":"126.857667ms","start":"2026-07-21T07:18:40.848202Z","end":"2026-07-21T07:18:40.97506Z","steps":["trace[296691733] 'process raft request'  (duration: 126.052582ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:18:40.975125Z","caller":"traceutil/trace.go:171","msg":"trace[1559480955] transaction","detail":"{read_only:false; response_revision:17694; number_of_response:1; }","duration":"126.829126ms","start":"2026-07-21T07:18:40.848289Z","end":"2026-07-21T07:18:40.975118Z","steps":["trace[1559480955] 'process raft request'  (duration: 125.99946ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:40.976074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.331575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225402"}
{"level":"info","ts":"2026-07-21T07:18:40.97613Z","caller":"traceutil/trace.go:171","msg":"trace[1983122018] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:17695; }","duration":"218.424699ms","start":"2026-07-21T07:18:40.757692Z","end":"2026-07-21T07:18:40.976117Z","steps":["trace[1983122018] 'agreement among raft nodes before linearized reading'  (duration: 217.219085ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:18:40.991927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.982169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112169"}
{"level":"info","ts":"2026-07-21T07:18:40.992116Z","caller":"traceutil/trace.go:171","msg":"trace[789655598] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:17695; }","duration":"104.116022ms","start":"2026-07-21T07:18:40.887892Z","end":"2026-07-21T07:18:40.992008Z","steps":["trace[789655598] 'agreement among raft nodes before linearized reading'  (duration: 88.27081ms)","trace[789655598] 'range keys from bolt db'  (duration: 15.058797ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:18:46.176457Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15320}
{"level":"info","ts":"2026-07-21T07:18:46.274777Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15320,"took":"93.892836ms","hash":99980853,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":32370688,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-21T07:18:46.274846Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":99980853,"revision":15320,"compact-revision":12859}
{"level":"info","ts":"2026-07-21T07:22:13.297007Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fed19d9291630e09","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-21T07:22:13.301108Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-21T07:22:13.301187Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-21T07:23:46.182859Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17750}
{"level":"info","ts":"2026-07-21T07:23:46.285015Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17750,"took":"98.129698ms","hash":215074545,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":33443840,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-07-21T07:23:46.285091Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":215074545,"revision":17750,"compact-revision":15320}
{"level":"warn","ts":"2026-07-21T07:23:56.599802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.743511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:23:56.599909Z","caller":"traceutil/trace.go:171","msg":"trace[1747321819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20082; }","duration":"128.899514ms","start":"2026-07-21T07:23:56.470985Z","end":"2026-07-21T07:23:56.599884Z","steps":["trace[1747321819] 'range keys from in-memory index tree'  (duration: 128.642839ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:12.856369Z","caller":"traceutil/trace.go:171","msg":"trace[1247122387] transaction","detail":"{read_only:false; response_revision:20165; number_of_response:1; }","duration":"287.197418ms","start":"2026-07-21T07:24:12.569139Z","end":"2026-07-21T07:24:12.856337Z","steps":["trace[1247122387] 'process raft request'  (duration: 286.987883ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:12.941769Z","caller":"traceutil/trace.go:171","msg":"trace[901916100] transaction","detail":"{read_only:false; response_revision:20166; number_of_response:1; }","duration":"240.463438ms","start":"2026-07-21T07:24:12.701277Z","end":"2026-07-21T07:24:12.94174Z","steps":["trace[901916100] 'process raft request'  (duration: 239.574431ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:12.941942Z","caller":"traceutil/trace.go:171","msg":"trace[194129754] linearizableReadLoop","detail":"{readStateIndex:20841; appliedIndex:20839; }","duration":"163.673585ms","start":"2026-07-21T07:24:12.778237Z","end":"2026-07-21T07:24:12.94191Z","steps":["trace[194129754] 'read index received'  (duration: 78.124817ms)","trace[194129754] 'applied index is now lower than readState.Index'  (duration: 85.546408ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:24:12.942059Z","caller":"traceutil/trace.go:171","msg":"trace[1658076533] transaction","detail":"{read_only:false; response_revision:20167; number_of_response:1; }","duration":"199.371616ms","start":"2026-07-21T07:24:12.742674Z","end":"2026-07-21T07:24:12.942046Z","steps":["trace[1658076533] 'process raft request'  (duration: 199.008599ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:24:12.942436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.218306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-07-21T07:24:12.94245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.633821ms","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-07-21T07:24:12.942482Z","caller":"traceutil/trace.go:171","msg":"trace[1487722392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20167; }","duration":"164.326658ms","start":"2026-07-21T07:24:12.778143Z","end":"2026-07-21T07:24:12.942469Z","steps":["trace[1487722392] 'agreement among raft nodes before linearized reading'  (duration: 164.132484ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:24:12.942473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.199185ms","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-07-21T07:24:12.942514Z","caller":"traceutil/trace.go:171","msg":"trace[1948101385] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20167; }","duration":"135.752414ms","start":"2026-07-21T07:24:12.806745Z","end":"2026-07-21T07:24:12.942497Z","steps":["trace[1948101385] 'agreement among raft nodes before linearized reading'  (duration: 135.589231ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:12.942581Z","caller":"traceutil/trace.go:171","msg":"trace[712874064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20167; }","duration":"144.360748ms","start":"2026-07-21T07:24:12.79819Z","end":"2026-07-21T07:24:12.942551Z","steps":["trace[712874064] 'agreement among raft nodes before linearized reading'  (duration: 144.110513ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:24:12.942633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.310642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-07-21T07:24:12.942681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.166425ms","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-07-21T07:24:12.942744Z","caller":"traceutil/trace.go:171","msg":"trace[388034648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20167; }","duration":"129.512025ms","start":"2026-07-21T07:24:12.813207Z","end":"2026-07-21T07:24:12.942719Z","steps":["trace[388034648] 'agreement among raft nodes before linearized reading'  (duration: 129.179549ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:12.942809Z","caller":"traceutil/trace.go:171","msg":"trace[838998320] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20167; }","duration":"144.319187ms","start":"2026-07-21T07:24:12.798462Z","end":"2026-07-21T07:24:12.942781Z","steps":["trace[838998320] 'agreement among raft nodes before linearized reading'  (duration: 143.93369ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:24:13.164407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.709322ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098556599 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:20157 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:24:13.164652Z","caller":"traceutil/trace.go:171","msg":"trace[1703036468] transaction","detail":"{read_only:false; response_revision:20169; number_of_response:1; }","duration":"216.92716ms","start":"2026-07-21T07:24:12.94769Z","end":"2026-07-21T07:24:13.164617Z","steps":["trace[1703036468] 'process raft request'  (duration: 101.919811ms)","trace[1703036468] 'compare'  (duration: 114.462888ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:24:13.1647Z","caller":"traceutil/trace.go:171","msg":"trace[668046276] transaction","detail":"{read_only:false; response_revision:20171; number_of_response:1; }","duration":"215.750247ms","start":"2026-07-21T07:24:12.948922Z","end":"2026-07-21T07:24:13.164672Z","steps":["trace[668046276] 'process raft request'  (duration: 215.692716ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:13.165069Z","caller":"traceutil/trace.go:171","msg":"trace[2084657902] transaction","detail":"{read_only:false; response_revision:20170; number_of_response:1; }","duration":"216.414581ms","start":"2026-07-21T07:24:12.948621Z","end":"2026-07-21T07:24:13.165036Z","steps":["trace[2084657902] 'process raft request'  (duration: 215.895931ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:24:13.509595Z","caller":"traceutil/trace.go:171","msg":"trace[301690667] transaction","detail":"{read_only:false; response_revision:20172; number_of_response:1; }","duration":"125.467569ms","start":"2026-07-21T07:24:13.384071Z","end":"2026-07-21T07:24:13.509539Z","steps":["trace[301690667] 'process raft request'  (duration: 124.903457ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:25:03.340966Z","caller":"traceutil/trace.go:171","msg":"trace[1607576793] linearizableReadLoop","detail":"{readStateIndex:21407; appliedIndex:21406; }","duration":"136.157322ms","start":"2026-07-21T07:25:03.204776Z","end":"2026-07-21T07:25:03.340933Z","steps":["trace[1607576793] 'read index received'  (duration: 135.824946ms)","trace[1607576793] 'applied index is now lower than readState.Index'  (duration: 330.586µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:25:03.341028Z","caller":"traceutil/trace.go:171","msg":"trace[1970855848] transaction","detail":"{read_only:false; response_revision:20712; number_of_response:1; }","duration":"146.148872ms","start":"2026-07-21T07:25:03.194848Z","end":"2026-07-21T07:25:03.340997Z","steps":["trace[1970855848] 'process raft request'  (duration: 145.860237ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:25:03.34123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.429338ms","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-07-21T07:25:03.341283Z","caller":"traceutil/trace.go:171","msg":"trace[1579340739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20712; }","duration":"136.536219ms","start":"2026-07-21T07:25:03.204731Z","end":"2026-07-21T07:25:03.341267Z","steps":["trace[1579340739] 'agreement among raft nodes before linearized reading'  (duration: 136.336456ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:27:53.276776Z","caller":"traceutil/trace.go:171","msg":"trace[854707793] transaction","detail":"{read_only:false; response_revision:22191; number_of_response:1; }","duration":"157.06373ms","start":"2026-07-21T07:27:53.119678Z","end":"2026-07-21T07:27:53.276742Z","steps":["trace[854707793] 'process raft request'  (duration: 145.258346ms)","trace[854707793] 'compare'  (duration: 11.59552ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:27:53.280925Z","caller":"traceutil/trace.go:171","msg":"trace[1461896797] linearizableReadLoop","detail":"{readStateIndex:22933; appliedIndex:22931; }","duration":"137.755012ms","start":"2026-07-21T07:27:53.143146Z","end":"2026-07-21T07:27:53.280901Z","steps":["trace[1461896797] 'read index received'  (duration: 121.87719ms)","trace[1461896797] 'applied index is now lower than readState.Index'  (duration: 15.876992ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:27:53.281247Z","caller":"traceutil/trace.go:171","msg":"trace[1072855818] transaction","detail":"{read_only:false; response_revision:22192; number_of_response:1; }","duration":"141.431672ms","start":"2026-07-21T07:27:53.139802Z","end":"2026-07-21T07:27:53.281234Z","steps":["trace[1072855818] 'process raft request'  (duration: 140.900062ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:27:53.283178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.611734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/machinedeployments.cluster.x-k8s.io\" ","response":"range_response_count:1 size:67606"}
{"level":"info","ts":"2026-07-21T07:27:53.283246Z","caller":"traceutil/trace.go:171","msg":"trace[749348328] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/machinedeployments.cluster.x-k8s.io; range_end:; response_count:1; response_revision:22193; }","duration":"132.754278ms","start":"2026-07-21T07:27:53.150475Z","end":"2026-07-21T07:27:53.283229Z","steps":["trace[749348328] 'agreement among raft nodes before linearized reading'  (duration: 132.001994ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:27:53.28377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.602496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/capi-kubeadm-bootstrap-mutating-webhook-configuration\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:27:53.283821Z","caller":"traceutil/trace.go:171","msg":"trace[907087201] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/capi-kubeadm-bootstrap-mutating-webhook-configuration; range_end:; response_count:0; response_revision:22193; }","duration":"140.711468ms","start":"2026-07-21T07:27:53.143094Z","end":"2026-07-21T07:27:53.283805Z","steps":["trace[907087201] 'agreement among raft nodes before linearized reading'  (duration: 138.577168ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:28:02.271265Z","caller":"traceutil/trace.go:171","msg":"trace[1759741574] transaction","detail":"{read_only:false; response_revision:22576; number_of_response:1; }","duration":"270.761815ms","start":"2026-07-21T07:28:02.000482Z","end":"2026-07-21T07:28:02.271244Z","steps":["trace[1759741574] 'process raft request'  (duration: 270.417568ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:28:02.27671Z","caller":"traceutil/trace.go:171","msg":"trace[424037699] transaction","detail":"{read_only:false; response_revision:22577; number_of_response:1; }","duration":"135.115192ms","start":"2026-07-21T07:28:02.141552Z","end":"2026-07-21T07:28:02.276667Z","steps":["trace[424037699] 'process raft request'  (duration: 134.896968ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:28:46.188859Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20033}
{"level":"info","ts":"2026-07-21T07:28:46.301382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20033,"took":"106.64147ms","hash":1108270378,"current-db-size-bytes":58630144,"current-db-size":"59 MB","current-db-size-in-use-bytes":42319872,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-07-21T07:28:46.301487Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1108270378,"revision":20033,"compact-revision":17750}
{"level":"info","ts":"2026-07-21T07:29:31.826514Z","caller":"traceutil/trace.go:171","msg":"trace[1820445585] transaction","detail":"{read_only:false; response_revision:23521; number_of_response:1; }","duration":"115.268571ms","start":"2026-07-21T07:29:31.711202Z","end":"2026-07-21T07:29:31.82647Z","steps":["trace[1820445585] 'process raft request'  (duration: 100.260164ms)","trace[1820445585] 'compare'  (duration: 14.732372ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:31.756429Z","caller":"traceutil/trace.go:171","msg":"trace[1665129693] transaction","detail":"{read_only:false; response_revision:24708; number_of_response:1; }","duration":"188.437918ms","start":"2026-07-21T07:31:31.567965Z","end":"2026-07-21T07:31:31.756403Z","steps":["trace[1665129693] 'process raft request'  (duration: 188.245834ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:31.789167Z","caller":"traceutil/trace.go:171","msg":"trace[762871390] transaction","detail":"{read_only:false; response_revision:24709; number_of_response:1; }","duration":"184.644816ms","start":"2026-07-21T07:31:31.604484Z","end":"2026-07-21T07:31:31.789128Z","steps":["trace[762871390] 'process raft request'  (duration: 184.311529ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:32.074497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.017689ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098569158 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24694 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:31:32.074736Z","caller":"traceutil/trace.go:171","msg":"trace[750993069] transaction","detail":"{read_only:false; response_revision:24710; number_of_response:1; }","duration":"280.252081ms","start":"2026-07-21T07:31:31.794448Z","end":"2026-07-21T07:31:32.0747Z","steps":["trace[750993069] 'process raft request'  (duration: 58.003108ms)","trace[750993069] 'compare'  (duration: 219.824667ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:32.074824Z","caller":"traceutil/trace.go:171","msg":"trace[1059998188] transaction","detail":"{read_only:false; response_revision:24711; number_of_response:1; }","duration":"279.864084ms","start":"2026-07-21T07:31:31.79494Z","end":"2026-07-21T07:31:32.074804Z","steps":["trace[1059998188] 'process raft request'  (duration: 279.67149ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.075113Z","caller":"traceutil/trace.go:171","msg":"trace[435383826] transaction","detail":"{read_only:false; response_revision:24712; number_of_response:1; }","duration":"278.925887ms","start":"2026-07-21T07:31:31.796177Z","end":"2026-07-21T07:31:32.075103Z","steps":["trace[435383826] 'process raft request'  (duration: 278.508529ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.075091Z","caller":"traceutil/trace.go:171","msg":"trace[1590912408] linearizableReadLoop","detail":"{readStateIndex:25512; appliedIndex:25509; }","duration":"178.715902ms","start":"2026-07-21T07:31:31.896324Z","end":"2026-07-21T07:31:32.07504Z","steps":["trace[1590912408] 'read index received'  (duration: 48.570948ms)","trace[1590912408] 'applied index is now lower than readState.Index'  (duration: 130.143174ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:32.075326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.964537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-21T07:31:32.075366Z","caller":"traceutil/trace.go:171","msg":"trace[1304681181] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:24712; }","duration":"179.081819ms","start":"2026-07-21T07:31:31.896271Z","end":"2026-07-21T07:31:32.075353Z","steps":["trace[1304681181] 'agreement among raft nodes before linearized reading'  (duration: 178.976937ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.230039Z","caller":"traceutil/trace.go:171","msg":"trace[1380679907] linearizableReadLoop","detail":"{readStateIndex:25514; appliedIndex:25512; }","duration":"154.833726ms","start":"2026-07-21T07:31:32.07518Z","end":"2026-07-21T07:31:32.230014Z","steps":["trace[1380679907] 'read index received'  (duration: 120.200275ms)","trace[1380679907] 'applied index is now lower than readState.Index'  (duration: 34.631731ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:32.230345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.879931ms","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-07-21T07:31:32.230394Z","caller":"traceutil/trace.go:171","msg":"trace[1617223679] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24715; }","duration":"304.980392ms","start":"2026-07-21T07:31:31.925402Z","end":"2026-07-21T07:31:32.230383Z","steps":["trace[1617223679] 'agreement among raft nodes before linearized reading'  (duration: 304.720957ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:32.230434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:31.925374Z","time spent":"305.050345ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-07-21T07:31:32.230519Z","caller":"traceutil/trace.go:171","msg":"trace[2007570771] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"275.845598ms","start":"2026-07-21T07:31:31.954637Z","end":"2026-07-21T07:31:32.230483Z","steps":["trace[2007570771] 'process raft request'  (duration: 275.249946ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.230672Z","caller":"traceutil/trace.go:171","msg":"trace[419506331] transaction","detail":"{read_only:false; response_revision:24715; number_of_response:1; }","duration":"102.784132ms","start":"2026-07-21T07:31:32.127875Z","end":"2026-07-21T07:31:32.230659Z","steps":["trace[419506331] 'process raft request'  (duration: 102.098408ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:32.230911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.756842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-21T07:31:32.230937Z","caller":"traceutil/trace.go:171","msg":"trace[1653165141] transaction","detail":"{read_only:false; response_revision:24713; number_of_response:1; }","duration":"291.327282ms","start":"2026-07-21T07:31:31.939594Z","end":"2026-07-21T07:31:32.230921Z","steps":["trace[1653165141] 'process raft request'  (duration: 255.909045ms)","trace[1653165141] 'compare'  (duration: 33.862717ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:32.230944Z","caller":"traceutil/trace.go:171","msg":"trace[965060518] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:24715; }","duration":"223.843703ms","start":"2026-07-21T07:31:32.007088Z","end":"2026-07-21T07:31:32.230932Z","steps":["trace[965060518] 'agreement among raft nodes before linearized reading'  (duration: 223.67164ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:32.580849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.723848ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098569166 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24697 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:31:32.581078Z","caller":"traceutil/trace.go:171","msg":"trace[314895533] transaction","detail":"{read_only:false; response_revision:24717; number_of_response:1; }","duration":"250.30375ms","start":"2026-07-21T07:31:32.330757Z","end":"2026-07-21T07:31:32.581061Z","steps":["trace[314895533] 'process raft request'  (duration: 250.208998ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.581373Z","caller":"traceutil/trace.go:171","msg":"trace[1996842117] transaction","detail":"{read_only:false; response_revision:24716; number_of_response:1; }","duration":"344.875115ms","start":"2026-07-21T07:31:32.236489Z","end":"2026-07-21T07:31:32.581364Z","steps":["trace[1996842117] 'process raft request'  (duration: 104.539807ms)","trace[1996842117] 'compare'  (duration: 238.89118ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:32.581416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:32.23647Z","time spent":"344.920516ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24697 > 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-07-21T07:31:32.581516Z","caller":"traceutil/trace.go:171","msg":"trace[636548324] linearizableReadLoop","detail":"{readStateIndex:25516; appliedIndex:25515; }","duration":"318.876229ms","start":"2026-07-21T07:31:32.262628Z","end":"2026-07-21T07:31:32.581505Z","steps":["trace[636548324] 'read index received'  (duration: 78.417548ms)","trace[636548324] 'applied index is now lower than readState.Index'  (duration: 240.457661ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:32.581649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.032042ms","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-07-21T07:31:32.581668Z","caller":"traceutil/trace.go:171","msg":"trace[1492290433] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24717; }","duration":"319.130044ms","start":"2026-07-21T07:31:32.262531Z","end":"2026-07-21T07:31:32.581661Z","steps":["trace[1492290433] 'agreement among raft nodes before linearized reading'  (duration: 319.033092ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:32.581687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:32.262483Z","time spent":"319.199785ms","remote":"127.0.0.1:52434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"warn","ts":"2026-07-21T07:31:32.582109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.12193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:32.582195Z","caller":"traceutil/trace.go:171","msg":"trace[590524376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24718; }","duration":"113.268072ms","start":"2026-07-21T07:31:32.468907Z","end":"2026-07-21T07:31:32.582176Z","steps":["trace[590524376] 'agreement among raft nodes before linearized reading'  (duration: 113.086428ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.582166Z","caller":"traceutil/trace.go:171","msg":"trace[483195440] transaction","detail":"{read_only:false; response_revision:24718; number_of_response:1; }","duration":"183.119396ms","start":"2026-07-21T07:31:32.398988Z","end":"2026-07-21T07:31:32.582107Z","steps":["trace[483195440] 'process raft request'  (duration: 182.812571ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:32.742392Z","caller":"traceutil/trace.go:171","msg":"trace[1521226074] linearizableReadLoop","detail":"{readStateIndex:25519; appliedIndex:25518; }","duration":"128.646996ms","start":"2026-07-21T07:31:32.613718Z","end":"2026-07-21T07:31:32.742365Z","steps":["trace[1521226074] 'read index received'  (duration: 128.203038ms)","trace[1521226074] 'applied index is now lower than readState.Index'  (duration: 442.248µs)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:32.742582Z","caller":"traceutil/trace.go:171","msg":"trace[940149775] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"132.260005ms","start":"2026-07-21T07:31:32.61031Z","end":"2026-07-21T07:31:32.74257Z","steps":["trace[940149775] 'process raft request'  (duration: 131.620513ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:32.742885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.151576ms","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-07-21T07:31:32.743055Z","caller":"traceutil/trace.go:171","msg":"trace[340270107] 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:24719; }","duration":"129.384019ms","start":"2026-07-21T07:31:32.613646Z","end":"2026-07-21T07:31:32.74303Z","steps":["trace[340270107] 'agreement among raft nodes before linearized reading'  (duration: 129.167975ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:37.906478Z","caller":"traceutil/trace.go:171","msg":"trace[653897973] transaction","detail":"{read_only:false; response_revision:24757; number_of_response:1; }","duration":"121.97726ms","start":"2026-07-21T07:31:37.784448Z","end":"2026-07-21T07:31:37.906425Z","steps":["trace[653897973] 'process raft request'  (duration: 121.294326ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.290066Z","caller":"traceutil/trace.go:171","msg":"trace[60299192] transaction","detail":"{read_only:false; response_revision:24758; number_of_response:1; }","duration":"138.518235ms","start":"2026-07-21T07:31:38.151516Z","end":"2026-07-21T07:31:38.290034Z","steps":["trace[60299192] 'process raft request'  (duration: 138.297401ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.439284Z","caller":"traceutil/trace.go:171","msg":"trace[503822379] transaction","detail":"{read_only:false; response_revision:24759; number_of_response:1; }","duration":"286.360176ms","start":"2026-07-21T07:31:38.152892Z","end":"2026-07-21T07:31:38.439252Z","steps":["trace[503822379] 'process raft request'  (duration: 286.071431ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.439373Z","caller":"traceutil/trace.go:171","msg":"trace[162653791] transaction","detail":"{read_only:false; response_revision:24762; number_of_response:1; }","duration":"184.201737ms","start":"2026-07-21T07:31:38.255151Z","end":"2026-07-21T07:31:38.439352Z","steps":["trace[162653791] 'process raft request'  (duration: 184.101035ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.439402Z","caller":"traceutil/trace.go:171","msg":"trace[864644874] transaction","detail":"{read_only:false; response_revision:24760; number_of_response:1; }","duration":"286.293006ms","start":"2026-07-21T07:31:38.15305Z","end":"2026-07-21T07:31:38.439343Z","steps":["trace[864644874] 'process raft request'  (duration: 286.099722ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.43951Z","caller":"traceutil/trace.go:171","msg":"trace[1088126839] transaction","detail":"{read_only:false; response_revision:24761; number_of_response:1; }","duration":"189.326335ms","start":"2026-07-21T07:31:38.250171Z","end":"2026-07-21T07:31:38.439498Z","steps":["trace[1088126839] 'process raft request'  (duration: 189.03847ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.439625Z","caller":"traceutil/trace.go:171","msg":"trace[1052159351] linearizableReadLoop","detail":"{readStateIndex:25564; appliedIndex:25558; }","duration":"178.665311ms","start":"2026-07-21T07:31:38.260947Z","end":"2026-07-21T07:31:38.439613Z","steps":["trace[1052159351] 'read index received'  (duration: 28.825991ms)","trace[1052159351] 'applied index is now lower than readState.Index'  (duration: 149.83684ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:38.439708Z","caller":"traceutil/trace.go:171","msg":"trace[1995886711] transaction","detail":"{read_only:false; response_revision:24763; number_of_response:1; }","duration":"183.223928ms","start":"2026-07-21T07:31:38.256473Z","end":"2026-07-21T07:31:38.439697Z","steps":["trace[1995886711] 'process raft request'  (duration: 182.80997ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:38.439823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.316237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:38.439884Z","caller":"traceutil/trace.go:171","msg":"trace[590765779] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:24763; }","duration":"120.42658ms","start":"2026-07-21T07:31:38.319432Z","end":"2026-07-21T07:31:38.439859Z","steps":["trace[590765779] 'agreement among raft nodes before linearized reading'  (duration: 120.290487ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:38.43988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.883045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:38.440017Z","caller":"traceutil/trace.go:171","msg":"trace[1573885145] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:24763; }","duration":"179.077279ms","start":"2026-07-21T07:31:38.260907Z","end":"2026-07-21T07:31:38.439984Z","steps":["trace[1573885145] 'agreement among raft nodes before linearized reading'  (duration: 178.857725ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.951808Z","caller":"traceutil/trace.go:171","msg":"trace[1915674462] transaction","detail":"{read_only:false; response_revision:24764; number_of_response:1; }","duration":"346.351113ms","start":"2026-07-21T07:31:38.604896Z","end":"2026-07-21T07:31:38.951247Z","steps":["trace[1915674462] 'process raft request'  (duration: 346.084308ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:38.952011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:38.604861Z","time spent":"347.045187ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24750 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-07-21T07:31:38.97067Z","caller":"traceutil/trace.go:171","msg":"trace[302804563] transaction","detail":"{read_only:false; response_revision:24766; number_of_response:1; }","duration":"187.690923ms","start":"2026-07-21T07:31:38.782957Z","end":"2026-07-21T07:31:38.970648Z","steps":["trace[302804563] 'process raft request'  (duration: 187.581021ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.970789Z","caller":"traceutil/trace.go:171","msg":"trace[283485580] linearizableReadLoop","detail":"{readStateIndex:25566; appliedIndex:25564; }","duration":"358.741529ms","start":"2026-07-21T07:31:38.612029Z","end":"2026-07-21T07:31:38.970771Z","steps":["trace[283485580] 'read index received'  (duration: 338.9013ms)","trace[283485580] 'applied index is now lower than readState.Index'  (duration: 19.837999ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:38.970672Z","caller":"traceutil/trace.go:171","msg":"trace[1412192707] transaction","detail":"{read_only:false; response_revision:24765; number_of_response:1; }","duration":"364.751714ms","start":"2026-07-21T07:31:38.605885Z","end":"2026-07-21T07:31:38.970637Z","steps":["trace[1412192707] 'process raft request'  (duration: 364.497218ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:38.970982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:38.60587Z","time spent":"365.01739ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24751 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:38.971129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.098086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-07-21T07:31:38.971186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.031908ms","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-07-21T07:31:38.971238Z","caller":"traceutil/trace.go:171","msg":"trace[1951546725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24767; }","duration":"359.246499ms","start":"2026-07-21T07:31:38.611972Z","end":"2026-07-21T07:31:38.971219Z","steps":["trace[1951546725] 'agreement among raft nodes before linearized reading'  (duration: 358.919203ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:38.971275Z","caller":"traceutil/trace.go:171","msg":"trace[223547000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24767; }","duration":"201.179901ms","start":"2026-07-21T07:31:38.770071Z","end":"2026-07-21T07:31:38.971251Z","steps":["trace[223547000] 'agreement among raft nodes before linearized reading'  (duration: 200.920156ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:38.971336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:38.611956Z","time spent":"359.364731ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-21T07:31:38.971392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.948029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:31:38.971511Z","caller":"traceutil/trace.go:171","msg":"trace[478804444] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24767; }","duration":"111.108561ms","start":"2026-07-21T07:31:38.860371Z","end":"2026-07-21T07:31:38.97148Z","steps":["trace[478804444] 'agreement among raft nodes before linearized reading'  (duration: 110.863067ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:38.971395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.137245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:31:38.971755Z","caller":"traceutil/trace.go:171","msg":"trace[99732618] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24767; }","duration":"107.565313ms","start":"2026-07-21T07:31:38.864177Z","end":"2026-07-21T07:31:38.971742Z","steps":["trace[99732618] 'agreement among raft nodes before linearized reading'  (duration: 106.910111ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:39.637753Z","caller":"traceutil/trace.go:171","msg":"trace[1815892345] linearizableReadLoop","detail":"{readStateIndex:25571; appliedIndex:25570; }","duration":"247.849442ms","start":"2026-07-21T07:31:39.389872Z","end":"2026-07-21T07:31:39.637721Z","steps":["trace[1815892345] 'read index received'  (duration: 247.635158ms)","trace[1815892345] 'applied index is now lower than readState.Index'  (duration: 213.084µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:39.638089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.193159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-07-21T07:31:39.638131Z","caller":"traceutil/trace.go:171","msg":"trace[237088186] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:24770; }","duration":"248.307211ms","start":"2026-07-21T07:31:39.389809Z","end":"2026-07-21T07:31:39.638116Z","steps":["trace[237088186] 'agreement among raft nodes before linearized reading'  (duration: 248.043156ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:39.638534Z","caller":"traceutil/trace.go:171","msg":"trace[1913083287] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"343.134952ms","start":"2026-07-21T07:31:39.295387Z","end":"2026-07-21T07:31:39.638522Z","steps":["trace[1913083287] 'process raft request'  (duration: 342.148684ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:39.638671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:39.295354Z","time spent":"343.237214ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24709 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:39.857343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.248444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:39.857452Z","caller":"traceutil/trace.go:171","msg":"trace[1139705633] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:24771; }","duration":"133.431948ms","start":"2026-07-21T07:31:39.723994Z","end":"2026-07-21T07:31:39.857426Z","steps":["trace[1139705633] 'count revisions from in-memory index tree'  (duration: 133.156152ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:40.611262Z","caller":"traceutil/trace.go:171","msg":"trace[1423367596] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"165.658944ms","start":"2026-07-21T07:31:40.445568Z","end":"2026-07-21T07:31:40.611227Z","steps":["trace[1423367596] 'process raft request'  (duration: 134.373306ms)","trace[1423367596] 'compare'  (duration: 31.121595ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:40.61131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.02224ms","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-07-21T07:31:40.611373Z","caller":"traceutil/trace.go:171","msg":"trace[827495250] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24774; }","duration":"166.178403ms","start":"2026-07-21T07:31:40.445177Z","end":"2026-07-21T07:31:40.611355Z","steps":["trace[827495250] 'range keys from in-memory index tree'  (duration: 165.696614ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:40.770971Z","caller":"traceutil/trace.go:171","msg":"trace[1176455522] linearizableReadLoop","detail":"{readStateIndex:25578; appliedIndex:25576; }","duration":"324.952725ms","start":"2026-07-21T07:31:40.445988Z","end":"2026-07-21T07:31:40.77094Z","steps":["trace[1176455522] 'read index received'  (duration: 134.121361ms)","trace[1176455522] 'applied index is now lower than readState.Index'  (duration: 190.829874ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:40.771018Z","caller":"traceutil/trace.go:171","msg":"trace[266864616] transaction","detail":"{read_only:false; response_revision:24777; number_of_response:1; }","duration":"324.476915ms","start":"2026-07-21T07:31:40.4465Z","end":"2026-07-21T07:31:40.770977Z","steps":["trace[266864616] 'process raft request'  (duration: 324.369073ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:40.77122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.446488Z","time spent":"324.625058ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24761 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-21T07:31:40.771013Z","caller":"traceutil/trace.go:171","msg":"trace[827925967] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"325.109617ms","start":"2026-07-21T07:31:40.445868Z","end":"2026-07-21T07:31:40.770978Z","steps":["trace[827925967] 'process raft request'  (duration: 324.764361ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:40.771315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.310751ms","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-07-21T07:31:40.771381Z","caller":"traceutil/trace.go:171","msg":"trace[1880091596] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24777; }","duration":"325.464574ms","start":"2026-07-21T07:31:40.445896Z","end":"2026-07-21T07:31:40.77136Z","steps":["trace[1880091596] 'agreement among raft nodes before linearized reading'  (duration: 325.174888ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:40.771414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.44585Z","time spent":"325.503204ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24763 > 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":"warn","ts":"2026-07-21T07:31:40.771436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.445866Z","time spent":"325.556726ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-21T07:31:40.771552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.944677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:40.771634Z","caller":"traceutil/trace.go:171","msg":"trace[434009628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24778; }","duration":"300.081389ms","start":"2026-07-21T07:31:40.471534Z","end":"2026-07-21T07:31:40.771615Z","steps":["trace[434009628] 'agreement among raft nodes before linearized reading'  (duration: 299.932237ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:40.771585Z","caller":"traceutil/trace.go:171","msg":"trace[1677780652] transaction","detail":"{read_only:false; response_revision:24778; number_of_response:1; }","duration":"155.260614ms","start":"2026-07-21T07:31:40.616261Z","end":"2026-07-21T07:31:40.771521Z","steps":["trace[1677780652] 'process raft request'  (duration: 154.880756ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:40.771678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.471508Z","time spent":"300.15821ms","remote":"127.0.0.1:52362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-21T07:31:40.77177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.968872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:40.771924Z","caller":"traceutil/trace.go:171","msg":"trace[2002588598] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:24778; }","duration":"151.133496ms","start":"2026-07-21T07:31:40.620722Z","end":"2026-07-21T07:31:40.771855Z","steps":["trace[2002588598] 'agreement among raft nodes before linearized reading'  (duration: 150.815049ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.079063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.746665ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098569319 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24760 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:31:41.079251Z","caller":"traceutil/trace.go:171","msg":"trace[1437989880] transaction","detail":"{read_only:false; response_revision:24779; number_of_response:1; }","duration":"303.25791ms","start":"2026-07-21T07:31:40.775929Z","end":"2026-07-21T07:31:41.079187Z","steps":["trace[1437989880] 'process raft request'  (duration: 115.25559ms)","trace[1437989880] 'compare'  (duration: 187.562522ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:41.079349Z","caller":"traceutil/trace.go:171","msg":"trace[123510916] transaction","detail":"{read_only:false; response_revision:24780; number_of_response:1; }","duration":"150.474142ms","start":"2026-07-21T07:31:40.928853Z","end":"2026-07-21T07:31:41.079327Z","steps":["trace[123510916] 'process raft request'  (duration: 150.36115ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:41.079417Z","caller":"traceutil/trace.go:171","msg":"trace[2051493999] linearizableReadLoop","detail":"{readStateIndex:25581; appliedIndex:25580; }","duration":"292.984353ms","start":"2026-07-21T07:31:40.786415Z","end":"2026-07-21T07:31:41.079399Z","steps":["trace[2051493999] 'read index received'  (duration: 104.78317ms)","trace[2051493999] 'applied index is now lower than readState.Index'  (duration: 188.198753ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:41.079499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.775908Z","time spent":"303.464463ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24760 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:41.079567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.158887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:41.079598Z","caller":"traceutil/trace.go:171","msg":"trace[153151741] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:24780; }","duration":"293.238498ms","start":"2026-07-21T07:31:40.786348Z","end":"2026-07-21T07:31:41.079586Z","steps":["trace[153151741] 'agreement among raft nodes before linearized reading'  (duration: 293.127216ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:41.270947Z","caller":"traceutil/trace.go:171","msg":"trace[57956017] transaction","detail":"{read_only:false; response_revision:24781; number_of_response:1; }","duration":"312.742932ms","start":"2026-07-21T07:31:40.95817Z","end":"2026-07-21T07:31:41.270913Z","steps":["trace[57956017] 'process raft request'  (duration: 258.799491ms)","trace[57956017] 'compare'  (duration: 53.682866ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:41.271156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.958139Z","time spent":"312.906494ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24764 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-07-21T07:31:41.271429Z","caller":"traceutil/trace.go:171","msg":"trace[1491191194] transaction","detail":"{read_only:false; response_revision:24783; number_of_response:1; }","duration":"293.253889ms","start":"2026-07-21T07:31:40.978145Z","end":"2026-07-21T07:31:41.271398Z","steps":["trace[1491191194] 'process raft request'  (duration: 293.086696ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:41.271739Z","caller":"traceutil/trace.go:171","msg":"trace[1778643006] transaction","detail":"{read_only:false; response_revision:24782; number_of_response:1; }","duration":"294.214847ms","start":"2026-07-21T07:31:40.977493Z","end":"2026-07-21T07:31:41.271707Z","steps":["trace[1778643006] 'process raft request'  (duration: 293.351201ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:41.27192Z","caller":"traceutil/trace.go:171","msg":"trace[428339763] linearizableReadLoop","detail":"{readStateIndex:25586; appliedIndex:25582; }","duration":"192.456724ms","start":"2026-07-21T07:31:41.079441Z","end":"2026-07-21T07:31:41.271897Z","steps":["trace[428339763] 'read index received'  (duration: 137.453514ms)","trace[428339763] 'applied index is now lower than readState.Index'  (duration: 55.00111ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:41.271938Z","caller":"traceutil/trace.go:171","msg":"trace[862209625] transaction","detail":"{read_only:false; response_revision:24784; number_of_response:1; }","duration":"293.410312ms","start":"2026-07-21T07:31:40.978495Z","end":"2026-07-21T07:31:41.271905Z","steps":["trace[862209625] 'process raft request'  (duration: 292.860732ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.272092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.745676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-21T07:31:41.272133Z","caller":"traceutil/trace.go:171","msg":"trace[221145139] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:24784; }","duration":"428.858457ms","start":"2026-07-21T07:31:40.843263Z","end":"2026-07-21T07:31:41.272121Z","steps":["trace[221145139] 'agreement among raft nodes before linearized reading'  (duration: 428.704355ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.272158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.676897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:31:41.27217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:40.84324Z","time spent":"428.919589ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "}
{"level":"warn","ts":"2026-07-21T07:31:41.272164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.921133ms","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-07-21T07:31:41.272208Z","caller":"traceutil/trace.go:171","msg":"trace[588493006] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24784; }","duration":"293.774519ms","start":"2026-07-21T07:31:40.978419Z","end":"2026-07-21T07:31:41.272194Z","steps":["trace[588493006] 'agreement among raft nodes before linearized reading'  (duration: 293.539284ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.27221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.80163ms","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-07-21T07:31:41.272225Z","caller":"traceutil/trace.go:171","msg":"trace[522914280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24784; }","duration":"280.995575ms","start":"2026-07-21T07:31:40.991216Z","end":"2026-07-21T07:31:41.272212Z","steps":["trace[522914280] 'agreement among raft nodes before linearized reading'  (duration: 280.785141ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:41.272245Z","caller":"traceutil/trace.go:171","msg":"trace[1454698852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24784; }","duration":"281.856851ms","start":"2026-07-21T07:31:40.99038Z","end":"2026-07-21T07:31:41.272237Z","steps":["trace[1454698852] 'agreement among raft nodes before linearized reading'  (duration: 281.701988ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.272355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.308167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:31:41.272393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.370728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:31:41.272417Z","caller":"traceutil/trace.go:171","msg":"trace[1067722914] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24784; }","duration":"295.4294ms","start":"2026-07-21T07:31:40.976979Z","end":"2026-07-21T07:31:41.272409Z","steps":["trace[1067722914] 'agreement among raft nodes before linearized reading'  (duration: 295.356448ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:41.272416Z","caller":"traceutil/trace.go:171","msg":"trace[2063350065] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24784; }","duration":"295.42472ms","start":"2026-07-21T07:31:40.976979Z","end":"2026-07-21T07:31:41.272404Z","steps":["trace[2063350065] 'agreement among raft nodes before linearized reading'  (duration: 295.195975ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.579707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.929483ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098569327 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24769 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:31:41.579802Z","caller":"traceutil/trace.go:171","msg":"trace[1562893183] transaction","detail":"{read_only:false; response_revision:24785; number_of_response:1; }","duration":"302.638368ms","start":"2026-07-21T07:31:41.277139Z","end":"2026-07-21T07:31:41.579778Z","steps":["trace[1562893183] 'process raft request'  (duration: 141.565382ms)","trace[1562893183] 'compare'  (duration: 160.562957ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:41.579844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:41.277103Z","time spent":"302.72345ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24769 > 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-07-21T07:31:41.632817Z","caller":"traceutil/trace.go:171","msg":"trace[929435141] transaction","detail":"{read_only:false; response_revision:24786; number_of_response:1; }","duration":"355.154301ms","start":"2026-07-21T07:31:41.277624Z","end":"2026-07-21T07:31:41.632778Z","steps":["trace[929435141] 'process raft request'  (duration: 354.931827ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:41.633027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:41.277599Z","time spent":"355.316275ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24768 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:41.916664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.614034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:41.916776Z","caller":"traceutil/trace.go:171","msg":"trace[1880986603] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24786; }","duration":"217.830689ms","start":"2026-07-21T07:31:41.698919Z","end":"2026-07-21T07:31:41.91675Z","steps":["trace[1880986603] 'range keys from in-memory index tree'  (duration: 217.502122ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:42.345271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.340721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:42.345363Z","caller":"traceutil/trace.go:171","msg":"trace[1924043406] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24787; }","duration":"138.499514ms","start":"2026-07-21T07:31:42.206844Z","end":"2026-07-21T07:31:42.345344Z","steps":["trace[1924043406] 'count revisions from in-memory index tree'  (duration: 138.240469ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:42.638443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.227982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:42.638515Z","caller":"traceutil/trace.go:171","msg":"trace[1860682733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24788; }","duration":"168.352324ms","start":"2026-07-21T07:31:42.470146Z","end":"2026-07-21T07:31:42.638498Z","steps":["trace[1860682733] 'range keys from in-memory index tree'  (duration: 168.09514ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:42.939464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.689087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-21T07:31:42.939567Z","caller":"traceutil/trace.go:171","msg":"trace[1252535216] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24789; }","duration":"162.86114ms","start":"2026-07-21T07:31:42.776679Z","end":"2026-07-21T07:31:42.939541Z","steps":["trace[1252535216] 'range keys from in-memory index tree'  (duration: 162.511633ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:42.939909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.005415ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098569347 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:24777 > 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-07-21T07:31:42.94026Z","caller":"traceutil/trace.go:171","msg":"trace[97268854] transaction","detail":"{read_only:false; response_revision:24790; number_of_response:1; }","duration":"161.694927ms","start":"2026-07-21T07:31:42.778518Z","end":"2026-07-21T07:31:42.940213Z","steps":["trace[97268854] 'process raft request'  (duration: 34.275384ms)","trace[97268854] 'compare'  (duration: 126.435074ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:42.940331Z","caller":"traceutil/trace.go:171","msg":"trace[838653740] transaction","detail":"{read_only:false; response_revision:24791; number_of_response:1; }","duration":"160.124738ms","start":"2026-07-21T07:31:42.780181Z","end":"2026-07-21T07:31:42.940306Z","steps":["trace[838653740] 'process raft request'  (duration: 159.887424ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:43.286346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.44372ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098569349 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24778 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:31:43.286486Z","caller":"traceutil/trace.go:171","msg":"trace[1508003081] linearizableReadLoop","detail":"{readStateIndex:25594; appliedIndex:25593; }","duration":"219.44525ms","start":"2026-07-21T07:31:43.067023Z","end":"2026-07-21T07:31:43.286468Z","steps":["trace[1508003081] 'read index received'  (duration: 55.741185ms)","trace[1508003081] 'applied index is now lower than readState.Index'  (duration: 163.702275ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:43.286508Z","caller":"traceutil/trace.go:171","msg":"trace[683781240] transaction","detail":"{read_only:false; response_revision:24792; number_of_response:1; }","duration":"340.641733ms","start":"2026-07-21T07:31:42.945844Z","end":"2026-07-21T07:31:43.286486Z","steps":["trace[683781240] 'process raft request'  (duration: 176.900327ms)","trace[683781240] 'compare'  (duration: 163.006502ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:43.286664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:42.945822Z","time spent":"340.757806ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24778 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:43.286676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.618153ms","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-07-21T07:31:43.286783Z","caller":"traceutil/trace.go:171","msg":"trace[172297559] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24792; }","duration":"219.796296ms","start":"2026-07-21T07:31:43.066958Z","end":"2026-07-21T07:31:43.286754Z","steps":["trace[172297559] 'agreement among raft nodes before linearized reading'  (duration: 219.576502ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:43.383259Z","caller":"traceutil/trace.go:171","msg":"trace[772164245] transaction","detail":"{read_only:false; response_revision:24793; number_of_response:1; }","duration":"104.111288ms","start":"2026-07-21T07:31:43.279108Z","end":"2026-07-21T07:31:43.383219Z","steps":["trace[772164245] 'process raft request'  (duration: 103.933534ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:43.426987Z","caller":"traceutil/trace.go:171","msg":"trace[1280707886] linearizableReadLoop","detail":"{readStateIndex:25598; appliedIndex:25595; }","duration":"140.453541ms","start":"2026-07-21T07:31:43.286507Z","end":"2026-07-21T07:31:43.426961Z","steps":["trace[1280707886] 'read index received'  (duration: 96.693716ms)","trace[1280707886] 'applied index is now lower than readState.Index'  (duration: 43.758525ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:43.426992Z","caller":"traceutil/trace.go:171","msg":"trace[1405902302] transaction","detail":"{read_only:false; response_revision:24794; number_of_response:1; }","duration":"147.556437ms","start":"2026-07-21T07:31:43.279385Z","end":"2026-07-21T07:31:43.426942Z","steps":["trace[1405902302] 'process raft request'  (duration: 130.058643ms)","trace[1405902302] 'compare'  (duration: 17.217909ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:43.427248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.583768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"warn","ts":"2026-07-21T07:31:43.427251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.173909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:31:43.427373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.805683ms","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-07-21T07:31:43.4274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.426264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:31:43.427375Z","caller":"traceutil/trace.go:171","msg":"trace[978787033] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24796; }","duration":"148.369982ms","start":"2026-07-21T07:31:43.278976Z","end":"2026-07-21T07:31:43.427346Z","steps":["trace[978787033] 'agreement among raft nodes before linearized reading'  (duration: 148.009666ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:43.427423Z","caller":"traceutil/trace.go:171","msg":"trace[1437807772] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24796; }","duration":"148.516286ms","start":"2026-07-21T07:31:43.2789Z","end":"2026-07-21T07:31:43.427417Z","steps":["trace[1437807772] 'agreement among raft nodes before linearized reading'  (duration: 148.425404ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:43.427418Z","caller":"traceutil/trace.go:171","msg":"trace[799150626] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24796; }","duration":"343.922255ms","start":"2026-07-21T07:31:43.083482Z","end":"2026-07-21T07:31:43.427405Z","steps":["trace[799150626] 'agreement among raft nodes before linearized reading'  (duration: 343.748352ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:43.427457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:43.083441Z","time spent":"344.006438ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-21T07:31:43.427448Z","caller":"traceutil/trace.go:171","msg":"trace[497644078] transaction","detail":"{read_only:false; response_revision:24796; number_of_response:1; }","duration":"147.590048ms","start":"2026-07-21T07:31:43.279816Z","end":"2026-07-21T07:31:43.427406Z","steps":["trace[497644078] 'process raft request'  (duration: 147.086928ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:43.427304Z","caller":"traceutil/trace.go:171","msg":"trace[858689472] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24796; }","duration":"224.678919ms","start":"2026-07-21T07:31:43.20261Z","end":"2026-07-21T07:31:43.427289Z","steps":["trace[858689472] 'agreement among raft nodes before linearized reading'  (duration: 224.450685ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:43.427537Z","caller":"traceutil/trace.go:171","msg":"trace[764016541] transaction","detail":"{read_only:false; response_revision:24795; number_of_response:1; }","duration":"148.156689ms","start":"2026-07-21T07:31:43.279354Z","end":"2026-07-21T07:31:43.427511Z","steps":["trace[764016541] 'process raft request'  (duration: 147.485476ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:43.427611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.732682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:31:43.427655Z","caller":"traceutil/trace.go:171","msg":"trace[1351434178] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24796; }","duration":"146.852485ms","start":"2026-07-21T07:31:43.280792Z","end":"2026-07-21T07:31:43.427645Z","steps":["trace[1351434178] 'agreement among raft nodes before linearized reading'  (duration: 146.714492ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:43.427266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.126961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:43.427847Z","caller":"traceutil/trace.go:171","msg":"trace[1026225153] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:24796; }","duration":"243.697113ms","start":"2026-07-21T07:31:43.184058Z","end":"2026-07-21T07:31:43.427755Z","steps":["trace[1026225153] 'agreement among raft nodes before linearized reading'  (duration: 243.119601ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:50.182371Z","caller":"traceutil/trace.go:171","msg":"trace[626408270] transaction","detail":"{read_only:false; response_revision:24849; number_of_response:1; }","duration":"117.284379ms","start":"2026-07-21T07:31:50.065054Z","end":"2026-07-21T07:31:50.182338Z","steps":["trace[626408270] 'process raft request'  (duration: 117.082785ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:50.674782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.291491ms","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-07-21T07:31:50.674919Z","caller":"traceutil/trace.go:171","msg":"trace[701415470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24849; }","duration":"248.498215ms","start":"2026-07-21T07:31:50.426393Z","end":"2026-07-21T07:31:50.674891Z","steps":["trace[701415470] 'range keys from in-memory index tree'  (duration: 248.012345ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:50.674766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.40455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-21T07:31:50.675349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.036936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:50.675398Z","caller":"traceutil/trace.go:171","msg":"trace[1909770475] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:24849; }","duration":"242.091373ms","start":"2026-07-21T07:31:50.433251Z","end":"2026-07-21T07:31:50.675342Z","steps":["trace[1909770475] 'count revisions from in-memory index tree'  (duration: 241.273328ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:50.675481Z","caller":"traceutil/trace.go:171","msg":"trace[1596018667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24849; }","duration":"204.22409ms","start":"2026-07-21T07:31:50.471215Z","end":"2026-07-21T07:31:50.675439Z","steps":["trace[1596018667] 'range keys from in-memory index tree'  (duration: 203.885453ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:50.675305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.372113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:50.676095Z","caller":"traceutil/trace.go:171","msg":"trace[764051464] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:24849; }","duration":"138.517964ms","start":"2026-07-21T07:31:50.537543Z","end":"2026-07-21T07:31:50.676061Z","steps":["trace[764051464] 'count revisions from in-memory index tree'  (duration: 137.25439ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.177958Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011514978098569512,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-07-21T07:31:51.542734Z","caller":"traceutil/trace.go:171","msg":"trace[1488112944] transaction","detail":"{read_only:false; response_revision:24850; number_of_response:1; }","duration":"875.995765ms","start":"2026-07-21T07:31:50.666703Z","end":"2026-07-21T07:31:51.542699Z","steps":["trace[1488112944] 'process raft request'  (duration: 875.789771ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.542936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.666468Z","time spent":"876.356262ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24837 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-21T07:31:51.796966Z","caller":"traceutil/trace.go:171","msg":"trace[1912554485] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"1.117811763s","start":"2026-07-21T07:31:50.679103Z","end":"2026-07-21T07:31:51.796915Z","steps":["trace[1912554485] 'process raft request'  (duration: 1.117312314s)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:51.797077Z","caller":"traceutil/trace.go:171","msg":"trace[486198388] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"1.109939032s","start":"2026-07-21T07:31:50.687112Z","end":"2026-07-21T07:31:51.797051Z","steps":["trace[486198388] 'process raft request'  (duration: 1.109480833s)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.797182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.679066Z","time spent":"1.118000176s","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24836 > 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-07-21T07:31:51.797378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.687085Z","time spent":"1.110062965s","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:24773 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-07-21T07:31:51.797592Z","caller":"traceutil/trace.go:171","msg":"trace[445172039] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"814.115423ms","start":"2026-07-21T07:31:50.983452Z","end":"2026-07-21T07:31:51.797567Z","steps":["trace[445172039] 'process raft request'  (duration: 813.540143ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.797734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.983442Z","time spent":"814.217415ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24839 > 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-07-21T07:31:51.797784Z","caller":"traceutil/trace.go:171","msg":"trace[1378846927] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"388.072689ms","start":"2026-07-21T07:31:51.409702Z","end":"2026-07-21T07:31:51.797774Z","steps":["trace[1378846927] 'process raft request'  (duration: 387.968177ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:51.797768Z","caller":"traceutil/trace.go:171","msg":"trace[791676210] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"705.887668ms","start":"2026-07-21T07:31:51.091849Z","end":"2026-07-21T07:31:51.797737Z","steps":["trace[791676210] 'process raft request'  (duration: 705.623233ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.797858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.409671Z","time spent":"388.14666ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24842 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:51.797918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.091822Z","time spent":"706.01094ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24820 > 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\" > >"}
{"level":"info","ts":"2026-07-21T07:31:51.797604Z","caller":"traceutil/trace.go:171","msg":"trace[1004857701] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"815.112474ms","start":"2026-07-21T07:31:50.982477Z","end":"2026-07-21T07:31:51.79759Z","steps":["trace[1004857701] 'process raft request'  (duration: 814.434151ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:51.79812Z","caller":"traceutil/trace.go:171","msg":"trace[701650957] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"338.350701ms","start":"2026-07-21T07:31:51.459732Z","end":"2026-07-21T07:31:51.798082Z","steps":["trace[701650957] 'process raft request'  (duration: 338.000703ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.798319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.459712Z","time spent":"338.493643ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24843 > 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-07-21T07:31:51.798372Z","caller":"traceutil/trace.go:171","msg":"trace[1745409961] linearizableReadLoop","detail":"{readStateIndex:25659; appliedIndex:25653; }","duration":"1.121437042s","start":"2026-07-21T07:31:50.676923Z","end":"2026-07-21T07:31:51.79836Z","steps":["trace[1745409961] 'read index received'  (duration: 865.615167ms)","trace[1745409961] 'applied index is now lower than readState.Index'  (duration: 255.821305ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:51.798441Z","caller":"traceutil/trace.go:171","msg":"trace[140678062] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"329.845349ms","start":"2026-07-21T07:31:51.468584Z","end":"2026-07-21T07:31:51.798429Z","steps":["trace[140678062] 'process raft request'  (duration: 329.686066ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.798478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121565445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:51.798508Z","caller":"traceutil/trace.go:171","msg":"trace[449109303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24859; }","duration":"1.121656967s","start":"2026-07-21T07:31:50.676841Z","end":"2026-07-21T07:31:51.798498Z","steps":["trace[449109303] 'agreement among raft nodes before linearized reading'  (duration: 1.121603956s)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.79851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.468576Z","time spent":"329.901149ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24845 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:51.79854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.67681Z","time spent":"1.121725079s","remote":"127.0.0.1:52366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-21T07:31:51.798547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.843743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:51.798581Z","caller":"traceutil/trace.go:171","msg":"trace[40760771] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"331.015171ms","start":"2026-07-21T07:31:51.46752Z","end":"2026-07-21T07:31:51.798535Z","steps":["trace[40760771] 'process raft request'  (duration: 330.46468ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:51.798642Z","caller":"traceutil/trace.go:171","msg":"trace[1851778587] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24859; }","duration":"908.943325ms","start":"2026-07-21T07:31:50.889677Z","end":"2026-07-21T07:31:51.798621Z","steps":["trace[1851778587] 'agreement among raft nodes before linearized reading'  (duration: 908.795692ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.7987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.889604Z","time spent":"909.081978ms","remote":"127.0.0.1:50316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "}
{"level":"warn","ts":"2026-07-21T07:31:51.798713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.798169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:31:51.79875Z","caller":"traceutil/trace.go:171","msg":"trace[593465415] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24859; }","duration":"339.8936ms","start":"2026-07-21T07:31:51.458847Z","end":"2026-07-21T07:31:51.79874Z","steps":["trace[593465415] 'agreement among raft nodes before linearized reading'  (duration: 339.749938ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.798758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.467502Z","time spent":"331.162943ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24844 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:51.798785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.458818Z","time spent":"339.960312ms","remote":"127.0.0.1:52504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-07-21T07:31:51.798911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.394689ms","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-07-21T07:31:51.798962Z","caller":"traceutil/trace.go:171","msg":"trace[914176894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24859; }","duration":"174.504891ms","start":"2026-07-21T07:31:51.624446Z","end":"2026-07-21T07:31:51.798951Z","steps":["trace[914176894] 'agreement among raft nodes before linearized reading'  (duration: 174.342058ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.798987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.075774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:31:51.798992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.130271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-21T07:31:51.799018Z","caller":"traceutil/trace.go:171","msg":"trace[326347896] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24859; }","duration":"340.163865ms","start":"2026-07-21T07:31:51.458847Z","end":"2026-07-21T07:31:51.799011Z","steps":["trace[326347896] 'agreement among raft nodes before linearized reading'  (duration: 340.103334ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.799021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.979589ms","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-07-21T07:31:51.799032Z","caller":"traceutil/trace.go:171","msg":"trace[1874330439] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24859; }","duration":"476.228393ms","start":"2026-07-21T07:31:51.322793Z","end":"2026-07-21T07:31:51.799021Z","steps":["trace[1874330439] 'agreement among raft nodes before linearized reading'  (duration: 476.09213ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.799038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.458819Z","time spent":"340.215287ms","remote":"127.0.0.1:52504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-07-21T07:31:51.799057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.322762Z","time spent":"476.290334ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-07-21T07:31:51.799056Z","caller":"traceutil/trace.go:171","msg":"trace[2115212282] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24859; }","duration":"321.01278ms","start":"2026-07-21T07:31:51.478033Z","end":"2026-07-21T07:31:51.799046Z","steps":["trace[2115212282] 'agreement among raft nodes before linearized reading'  (duration: 320.907928ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.799113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.295245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-21T07:31:51.79916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.477995Z","time spent":"321.151372ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-21T07:31:51.799168Z","caller":"traceutil/trace.go:171","msg":"trace[855278798] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:24859; }","duration":"354.390077ms","start":"2026-07-21T07:31:51.444763Z","end":"2026-07-21T07:31:51.799153Z","steps":["trace[855278798] 'agreement among raft nodes before linearized reading'  (duration: 354.295005ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.798934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.52731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:31:51.799219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.444745Z","time spent":"354.456608ms","remote":"127.0.0.1:52568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"info","ts":"2026-07-21T07:31:51.799226Z","caller":"traceutil/trace.go:171","msg":"trace[2028042608] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:24859; }","duration":"343.873236ms","start":"2026-07-21T07:31:51.455343Z","end":"2026-07-21T07:31:51.799216Z","steps":["trace[2028042608] 'agreement among raft nodes before linearized reading'  (duration: 343.485959ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:51.799259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.455314Z","time spent":"343.935147ms","remote":"127.0.0.1:52504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "}
{"level":"warn","ts":"2026-07-21T07:31:51.798381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:50.982447Z","time spent":"815.509612ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24838 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-21T07:31:52.191899Z","caller":"traceutil/trace.go:171","msg":"trace[781467890] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"387.857515ms","start":"2026-07-21T07:31:51.804017Z","end":"2026-07-21T07:31:52.191874Z","steps":["trace[781467890] 'process raft request'  (duration: 387.681782ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:52.192109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.803996Z","time spent":"388.018048ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24840 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-07-21T07:31:52.299141Z","caller":"traceutil/trace.go:171","msg":"trace[1631205995] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"494.522952ms","start":"2026-07-21T07:31:51.804581Z","end":"2026-07-21T07:31:52.299104Z","steps":["trace[1631205995] 'process raft request'  (duration: 416.682186ms)","trace[1631205995] 'compare'  (duration: 77.112002ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:52.299478Z","caller":"traceutil/trace.go:171","msg":"trace[1865395808] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"494.407401ms","start":"2026-07-21T07:31:51.805019Z","end":"2026-07-21T07:31:52.299426Z","steps":["trace[1865395808] 'process raft request'  (duration: 493.962351ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:52.299885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.804987Z","time spent":"494.729487ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24848 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-21T07:31:52.300161Z","caller":"traceutil/trace.go:171","msg":"trace[2057268765] linearizableReadLoop","detail":"{readStateIndex:25667; appliedIndex:25664; }","duration":"494.755097ms","start":"2026-07-21T07:31:51.805391Z","end":"2026-07-21T07:31:52.300146Z","steps":["trace[2057268765] 'read index received'  (duration: 386.852696ms)","trace[2057268765] 'applied index is now lower than readState.Index'  (duration: 107.895411ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:31:52.300449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.024262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:52.300581Z","caller":"traceutil/trace.go:171","msg":"trace[806191667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24863; }","duration":"495.185936ms","start":"2026-07-21T07:31:51.805367Z","end":"2026-07-21T07:31:52.300553Z","steps":["trace[806191667] 'agreement among raft nodes before linearized reading'  (duration: 494.998162ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:52.300666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.805358Z","time spent":"495.292038ms","remote":"127.0.0.1:52362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-21T07:31:52.30082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.502666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-07-21T07:31:52.30096Z","caller":"traceutil/trace.go:171","msg":"trace[1810466526] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:24863; }","duration":"402.689279ms","start":"2026-07-21T07:31:51.898248Z","end":"2026-07-21T07:31:52.300937Z","steps":["trace[1810466526] 'agreement among raft nodes before linearized reading'  (duration: 402.370393ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:52.301001Z","caller":"traceutil/trace.go:171","msg":"trace[1344467655] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"495.756586ms","start":"2026-07-21T07:31:51.805219Z","end":"2026-07-21T07:31:52.300976Z","steps":["trace[1344467655] 'process raft request'  (duration: 494.164056ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:52.301038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.898198Z","time spent":"402.824582ms","remote":"127.0.0.1:52488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1883,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" "}
{"level":"warn","ts":"2026-07-21T07:31:52.301352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.805211Z","time spent":"495.838448ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24846 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-21T07:31:52.301483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.326924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"warn","ts":"2026-07-21T07:31:52.3015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.546742ms","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-07-21T07:31:52.301539Z","caller":"traceutil/trace.go:171","msg":"trace[751001371] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24863; }","duration":"235.433086ms","start":"2026-07-21T07:31:52.066094Z","end":"2026-07-21T07:31:52.301527Z","steps":["trace[751001371] 'agreement among raft nodes before linearized reading'  (duration: 235.265013ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:52.301575Z","caller":"traceutil/trace.go:171","msg":"trace[1382588005] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24863; }","duration":"108.753837ms","start":"2026-07-21T07:31:52.192803Z","end":"2026-07-21T07:31:52.301556Z","steps":["trace[1382588005] 'agreement among raft nodes before linearized reading'  (duration: 108.541363ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:52.301794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.895049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:31:52.301846Z","caller":"traceutil/trace.go:171","msg":"trace[36170924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24863; }","duration":"373.975161ms","start":"2026-07-21T07:31:51.927857Z","end":"2026-07-21T07:31:52.301832Z","steps":["trace[36170924] 'agreement among raft nodes before linearized reading'  (duration: 373.890039ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:52.301879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.927842Z","time spent":"374.027722ms","remote":"127.0.0.1:42264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "}
{"level":"warn","ts":"2026-07-21T07:31:52.303129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:31:51.804573Z","time spent":"494.738166ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24847 > 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-07-21T07:31:54.431702Z","caller":"traceutil/trace.go:171","msg":"trace[469340819] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"123.59459ms","start":"2026-07-21T07:31:54.30808Z","end":"2026-07-21T07:31:54.431674Z","steps":["trace[469340819] 'process raft request'  (duration: 123.392446ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:54.558942Z","caller":"traceutil/trace.go:171","msg":"trace[1082287016] linearizableReadLoop","detail":"{readStateIndex:25742; appliedIndex:25739; }","duration":"245.429597ms","start":"2026-07-21T07:31:54.313477Z","end":"2026-07-21T07:31:54.558907Z","steps":["trace[1082287016] 'read index received'  (duration: 118.115716ms)","trace[1082287016] 'applied index is now lower than readState.Index'  (duration: 127.312131ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:31:54.559045Z","caller":"traceutil/trace.go:171","msg":"trace[1035670223] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"245.972587ms","start":"2026-07-21T07:31:54.313025Z","end":"2026-07-21T07:31:54.558998Z","steps":["trace[1035670223] 'process raft request'  (duration: 245.581079ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:54.559098Z","caller":"traceutil/trace.go:171","msg":"trace[95787412] transaction","detail":"{read_only:false; response_revision:24937; number_of_response:1; }","duration":"245.650001ms","start":"2026-07-21T07:31:54.313416Z","end":"2026-07-21T07:31:54.559066Z","steps":["trace[95787412] 'process raft request'  (duration: 245.397336ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:31:54.559313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.807964ms","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-07-21T07:31:54.559316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.28149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-manila-server-0.18c43da0d1f127aa\" ","response":"range_response_count:1 size:1010"}
{"level":"info","ts":"2026-07-21T07:31:54.55937Z","caller":"traceutil/trace.go:171","msg":"trace[2049070951] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24937; }","duration":"245.900895ms","start":"2026-07-21T07:31:54.313455Z","end":"2026-07-21T07:31:54.559356Z","steps":["trace[2049070951] 'agreement among raft nodes before linearized reading'  (duration: 245.62894ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:54.559391Z","caller":"traceutil/trace.go:171","msg":"trace[1961381516] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-manila-server-0.18c43da0d1f127aa; range_end:; response_count:1; response_revision:24937; }","duration":"194.414141ms","start":"2026-07-21T07:31:54.364953Z","end":"2026-07-21T07:31:54.559367Z","steps":["trace[1961381516] 'agreement among raft nodes before linearized reading'  (duration: 194.174657ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:31:54.719532Z","caller":"traceutil/trace.go:171","msg":"trace[952706538] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"118.491082ms","start":"2026-07-21T07:31:54.60101Z","end":"2026-07-21T07:31:54.719501Z","steps":["trace[952706538] 'process raft request'  (duration: 118.248228ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:00.619073Z","caller":"traceutil/trace.go:171","msg":"trace[1964706793] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"151.94521ms","start":"2026-07-21T07:32:00.467089Z","end":"2026-07-21T07:32:00.619035Z","steps":["trace[1964706793] 'process raft request'  (duration: 151.633484ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:00.772274Z","caller":"traceutil/trace.go:171","msg":"trace[855172461] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"148.22917ms","start":"2026-07-21T07:32:00.62401Z","end":"2026-07-21T07:32:00.772239Z","steps":["trace[855172461] 'process raft request'  (duration: 148.107568ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:00.772463Z","caller":"traceutil/trace.go:171","msg":"trace[1917660550] linearizableReadLoop","detail":"{readStateIndex:25811; appliedIndex:25808; }","duration":"142.261976ms","start":"2026-07-21T07:32:00.630168Z","end":"2026-07-21T07:32:00.77243Z","steps":["trace[1917660550] 'read index received'  (duration: 93.871183ms)","trace[1917660550] 'applied index is now lower than readState.Index'  (duration: 48.389273ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:00.772612Z","caller":"traceutil/trace.go:171","msg":"trace[821174785] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"147.630929ms","start":"2026-07-21T07:32:00.624968Z","end":"2026-07-21T07:32:00.772599Z","steps":["trace[821174785] 'process raft request'  (duration: 147.211921ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:00.772515Z","caller":"traceutil/trace.go:171","msg":"trace[366093604] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"148.734229ms","start":"2026-07-21T07:32:00.623745Z","end":"2026-07-21T07:32:00.772479Z","steps":["trace[366093604] 'process raft request'  (duration: 100.271884ms)","trace[366093604] 'compare'  (duration: 47.896525ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:00.772905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.694004ms","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-07-21T07:32:00.77302Z","caller":"traceutil/trace.go:171","msg":"trace[1865039569] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:25003; }","duration":"142.877898ms","start":"2026-07-21T07:32:00.630118Z","end":"2026-07-21T07:32:00.772996Z","steps":["trace[1865039569] 'agreement among raft nodes before linearized reading'  (duration: 142.629833ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:01.028936Z","caller":"traceutil/trace.go:171","msg":"trace[2054885159] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"244.178472ms","start":"2026-07-21T07:32:00.784722Z","end":"2026-07-21T07:32:01.0289Z","steps":["trace[2054885159] 'process raft request'  (duration: 243.61806ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:19.118302Z","caller":"traceutil/trace.go:171","msg":"trace[121464132] transaction","detail":"{read_only:false; response_revision:25147; number_of_response:1; }","duration":"244.439707ms","start":"2026-07-21T07:32:18.873835Z","end":"2026-07-21T07:32:19.118275Z","steps":["trace[121464132] 'process raft request'  (duration: 244.282454ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:19.292Z","caller":"traceutil/trace.go:171","msg":"trace[616396367] transaction","detail":"{read_only:false; response_revision:25148; number_of_response:1; }","duration":"417.629014ms","start":"2026-07-21T07:32:18.874324Z","end":"2026-07-21T07:32:19.291953Z","steps":["trace[616396367] 'process raft request'  (duration: 325.302431ms)","trace[616396367] 'compare'  (duration: 91.791313ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:19.292044Z","caller":"traceutil/trace.go:171","msg":"trace[2059089035] transaction","detail":"{read_only:false; response_revision:25149; number_of_response:1; }","duration":"416.036883ms","start":"2026-07-21T07:32:18.875975Z","end":"2026-07-21T07:32:19.292011Z","steps":["trace[2059089035] 'process raft request'  (duration: 415.91524ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:19.292193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:18.874308Z","time spent":"417.776527ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25131 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-21T07:32:19.292211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:18.875959Z","time spent":"416.154496ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25133 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-07-21T07:32:19.561509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.995995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-07-21T07:32:19.561601Z","caller":"traceutil/trace.go:171","msg":"trace[1692049309] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:25149; }","duration":"170.133767ms","start":"2026-07-21T07:32:19.391441Z","end":"2026-07-21T07:32:19.561575Z","steps":["trace[1692049309] 'range keys from in-memory index tree'  (duration: 169.647888ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:19.971967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.203549ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098570278 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:25076 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:67 lease:1011514978098570276 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:32:19.972174Z","caller":"traceutil/trace.go:171","msg":"trace[1998329639] transaction","detail":"{read_only:false; response_revision:25150; number_of_response:1; }","duration":"394.35349ms","start":"2026-07-21T07:32:19.577736Z","end":"2026-07-21T07:32:19.97209Z","steps":["trace[1998329639] 'process raft request'  (duration: 255.929866ms)","trace[1998329639] 'compare'  (duration: 138.026576ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:19.972231Z","caller":"traceutil/trace.go:171","msg":"trace[293548818] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"330.070202ms","start":"2026-07-21T07:32:19.642145Z","end":"2026-07-21T07:32:19.972215Z","steps":["trace[293548818] 'process raft request'  (duration: 329.93181ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:19.972292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.642091Z","time spent":"330.178254ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25136 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-21T07:32:19.972391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.577721Z","time spent":"394.547913ms","remote":"127.0.0.1:52376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.22\" mod_revision:25076 > success:<request_put:<key:\"/registry/masterleases/199.204.45.22\" value_size:67 lease:1011514978098570276 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.22\" > >"}
{"level":"info","ts":"2026-07-21T07:32:19.97275Z","caller":"traceutil/trace.go:171","msg":"trace[1823635057] linearizableReadLoop","detail":"{readStateIndex:25962; appliedIndex:25961; }","duration":"375.621012ms","start":"2026-07-21T07:32:19.597106Z","end":"2026-07-21T07:32:19.972727Z","steps":["trace[1823635057] 'read index received'  (duration: 236.550096ms)","trace[1823635057] 'applied index is now lower than readState.Index'  (duration: 139.068256ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:19.973226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.121531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10853"}
{"level":"info","ts":"2026-07-21T07:32:19.973293Z","caller":"traceutil/trace.go:171","msg":"trace[839313763] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25151; }","duration":"376.251303ms","start":"2026-07-21T07:32:19.59703Z","end":"2026-07-21T07:32:19.973282Z","steps":["trace[839313763] 'agreement among raft nodes before linearized reading'  (duration: 375.803835ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:19.973327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.597007Z","time spent":"376.312155ms","remote":"127.0.0.1:52532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10876,"request content":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" "}
{"level":"info","ts":"2026-07-21T07:32:20.140776Z","caller":"traceutil/trace.go:171","msg":"trace[1875223115] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"236.336122ms","start":"2026-07-21T07:32:19.904367Z","end":"2026-07-21T07:32:20.140703Z","steps":["trace[1875223115] 'process raft request'  (duration: 236.041436ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.140851Z","caller":"traceutil/trace.go:171","msg":"trace[1279133398] transaction","detail":"{read_only:false; response_revision:25154; number_of_response:1; }","duration":"236.319252ms","start":"2026-07-21T07:32:19.904477Z","end":"2026-07-21T07:32:20.140796Z","steps":["trace[1279133398] 'process raft request'  (duration: 236.120938ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.140942Z","caller":"traceutil/trace.go:171","msg":"trace[305535510] transaction","detail":"{read_only:false; response_revision:25155; number_of_response:1; }","duration":"234.511597ms","start":"2026-07-21T07:32:19.906388Z","end":"2026-07-21T07:32:20.140899Z","steps":["trace[305535510] 'process raft request'  (duration: 234.251563ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.141101Z","caller":"traceutil/trace.go:171","msg":"trace[715419189] transaction","detail":"{read_only:false; response_revision:25156; number_of_response:1; }","duration":"233.683662ms","start":"2026-07-21T07:32:19.907384Z","end":"2026-07-21T07:32:20.141067Z","steps":["trace[715419189] 'process raft request'  (duration: 233.286154ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.141384Z","caller":"traceutil/trace.go:171","msg":"trace[282119675] transaction","detail":"{read_only:false; response_revision:25157; number_of_response:1; }","duration":"229.183756ms","start":"2026-07-21T07:32:19.91219Z","end":"2026-07-21T07:32:20.141374Z","steps":["trace[282119675] 'process raft request'  (duration: 228.705517ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.14142Z","caller":"traceutil/trace.go:171","msg":"trace[863707254] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"158.462105ms","start":"2026-07-21T07:32:19.982935Z","end":"2026-07-21T07:32:20.141397Z","steps":["trace[863707254] 'process raft request'  (duration: 158.389643ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.141619Z","caller":"traceutil/trace.go:171","msg":"trace[820931320] linearizableReadLoop","detail":"{readStateIndex:25969; appliedIndex:25964; }","duration":"168.739022ms","start":"2026-07-21T07:32:19.972804Z","end":"2026-07-21T07:32:20.141543Z","steps":["trace[820931320] 'read index received'  (duration: 17.26718ms)","trace[820931320] 'applied index is now lower than readState.Index'  (duration: 151.455381ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:20.141749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.06373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:32:20.141751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.480868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"warn","ts":"2026-07-21T07:32:20.141776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.160426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-07-21T07:32:20.141787Z","caller":"traceutil/trace.go:171","msg":"trace[1228874186] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25158; }","duration":"265.58145ms","start":"2026-07-21T07:32:19.876198Z","end":"2026-07-21T07:32:20.14178Z","steps":["trace[1228874186] 'agreement among raft nodes before linearized reading'  (duration: 265.417277ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.141787Z","caller":"traceutil/trace.go:171","msg":"trace[590107100] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25158; }","duration":"255.141171ms","start":"2026-07-21T07:32:19.886635Z","end":"2026-07-21T07:32:20.141776Z","steps":["trace[590107100] 'agreement among raft nodes before linearized reading'  (duration: 254.978158ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.141806Z","caller":"traceutil/trace.go:171","msg":"trace[1401241744] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25158; }","duration":"515.200707ms","start":"2026-07-21T07:32:19.626592Z","end":"2026-07-21T07:32:20.141793Z","steps":["trace[1401241744] 'agreement among raft nodes before linearized reading'  (duration: 515.125806ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.141836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.626583Z","time spent":"515.247638ms","remote":"127.0.0.1:52488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1883,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"warn","ts":"2026-07-21T07:32:20.141915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.734779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-07-21T07:32:20.141928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.824959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:32:20.141943Z","caller":"traceutil/trace.go:171","msg":"trace[849671560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25158; }","duration":"181.865432ms","start":"2026-07-21T07:32:19.960071Z","end":"2026-07-21T07:32:20.141937Z","steps":["trace[849671560] 'agreement among raft nodes before linearized reading'  (duration: 181.78146ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.141974Z","caller":"traceutil/trace.go:171","msg":"trace[866963925] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:25158; }","duration":"515.92703ms","start":"2026-07-21T07:32:19.626029Z","end":"2026-07-21T07:32:20.141956Z","steps":["trace[866963925] 'agreement among raft nodes before linearized reading'  (duration: 515.790618ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.14201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.202371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"warn","ts":"2026-07-21T07:32:20.142021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.626018Z","time spent":"515.995281ms","remote":"127.0.0.1:50454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "}
{"level":"info","ts":"2026-07-21T07:32:20.142035Z","caller":"traceutil/trace.go:171","msg":"trace[1211066761] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25158; }","duration":"167.268283ms","start":"2026-07-21T07:32:19.974762Z","end":"2026-07-21T07:32:20.14203Z","steps":["trace[1211066761] 'agreement among raft nodes before linearized reading'  (duration: 167.217812ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.141692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.032787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:32:20.142124Z","caller":"traceutil/trace.go:171","msg":"trace[876997512] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25158; }","duration":"268.551037ms","start":"2026-07-21T07:32:19.873566Z","end":"2026-07-21T07:32:20.142117Z","steps":["trace[876997512] 'agreement among raft nodes before linearized reading'  (duration: 267.988176ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.142138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.099124ms","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-07-21T07:32:20.142182Z","caller":"traceutil/trace.go:171","msg":"trace[1528807489] 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:25158; }","duration":"351.209326ms","start":"2026-07-21T07:32:19.790962Z","end":"2026-07-21T07:32:20.142171Z","steps":["trace[1528807489] 'agreement among raft nodes before linearized reading'  (duration: 351.096313ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.142213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.790933Z","time spent":"351.273467ms","remote":"127.0.0.1:34926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-07-21T07:32:20.143514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.164501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-21T07:32:20.143561Z","caller":"traceutil/trace.go:171","msg":"trace[1427593813] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25158; }","duration":"476.294854ms","start":"2026-07-21T07:32:19.667254Z","end":"2026-07-21T07:32:20.143549Z","steps":["trace[1427593813] 'agreement among raft nodes before linearized reading'  (duration: 474.368187ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.143583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:19.667225Z","time spent":"476.351965ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":2649,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-07-21T07:32:20.528333Z","caller":"traceutil/trace.go:171","msg":"trace[1643896532] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"377.998937ms","start":"2026-07-21T07:32:20.150291Z","end":"2026-07-21T07:32:20.52829Z","steps":["trace[1643896532] 'process raft request'  (duration: 377.722862ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.528419Z","caller":"traceutil/trace.go:171","msg":"trace[1523271570] linearizableReadLoop","detail":"{readStateIndex:25975; appliedIndex:25971; }","duration":"368.118048ms","start":"2026-07-21T07:32:20.160276Z","end":"2026-07-21T07:32:20.528394Z","steps":["trace[1523271570] 'read index received'  (duration: 367.72873ms)","trace[1523271570] 'applied index is now lower than readState.Index'  (duration: 387.918µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:20.528528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:20.150275Z","time spent":"378.15146ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-manila-9r2v4\" mod_revision:25007 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-9r2v4\" value_size:1351 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-9r2v4\" > >"}
{"level":"info","ts":"2026-07-21T07:32:20.528707Z","caller":"traceutil/trace.go:171","msg":"trace[1977812754] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"377.928084ms","start":"2026-07-21T07:32:20.150765Z","end":"2026-07-21T07:32:20.528693Z","steps":["trace[1977812754] 'process raft request'  (duration: 377.431795ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.528841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:20.150749Z","time spent":"377.995727ms","remote":"127.0.0.1:52504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" mod_revision:25008 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" value_size:823 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-manila\" > >"}
{"level":"warn","ts":"2026-07-21T07:32:20.529096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.857055ms","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-07-21T07:32:20.529153Z","caller":"traceutil/trace.go:171","msg":"trace[1371699423] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25163; }","duration":"378.928936ms","start":"2026-07-21T07:32:20.150205Z","end":"2026-07-21T07:32:20.529134Z","steps":["trace[1371699423] 'agreement among raft nodes before linearized reading'  (duration: 378.809743ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.529185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.422912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-07-21T07:32:20.529205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:20.150195Z","time spent":"379.002397ms","remote":"127.0.0.1:52548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"info","ts":"2026-07-21T07:32:20.529375Z","caller":"traceutil/trace.go:171","msg":"trace[430359155] transaction","detail":"{read_only:false; response_revision:25163; number_of_response:1; }","duration":"372.637755ms","start":"2026-07-21T07:32:20.156725Z","end":"2026-07-21T07:32:20.529362Z","steps":["trace[430359155] 'process raft request'  (duration: 371.609505ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.529436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:20.156694Z","time spent":"372.704346ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9630,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" mod_revision:24911 > success:<request_put:<key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" value_size:9567 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" > >"}
{"level":"info","ts":"2026-07-21T07:32:20.529472Z","caller":"traceutil/trace.go:171","msg":"trace[1953855851] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"377.398586ms","start":"2026-07-21T07:32:20.152034Z","end":"2026-07-21T07:32:20.529432Z","steps":["trace[1953855851] 'process raft request'  (duration: 376.223153ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.529677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:20.152024Z","time spent":"377.538369ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-lh84j\" mod_revision:25005 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-lh84j\" value_size:1420 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-manila-nodes-lh84j\" > >"}
{"level":"info","ts":"2026-07-21T07:32:20.53101Z","caller":"traceutil/trace.go:171","msg":"trace[2052038386] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25163; }","duration":"193.510224ms","start":"2026-07-21T07:32:20.335705Z","end":"2026-07-21T07:32:20.529216Z","steps":["trace[2052038386] 'agreement among raft nodes before linearized reading'  (duration: 193.354911ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.696409Z","caller":"traceutil/trace.go:171","msg":"trace[763023518] linearizableReadLoop","detail":"{readStateIndex:25977; appliedIndex:25976; }","duration":"125.649968ms","start":"2026-07-21T07:32:20.570721Z","end":"2026-07-21T07:32:20.696371Z","steps":["trace[763023518] 'read index received'  (duration: 125.375193ms)","trace[763023518] 'applied index is now lower than readState.Index'  (duration: 273.805µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:20.696599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.832451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:32:20.696647Z","caller":"traceutil/trace.go:171","msg":"trace[754914019] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25165; }","duration":"125.942325ms","start":"2026-07-21T07:32:20.570691Z","end":"2026-07-21T07:32:20.696633Z","steps":["trace[754914019] 'agreement among raft nodes before linearized reading'  (duration: 125.818232ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.696909Z","caller":"traceutil/trace.go:171","msg":"trace[1713505806] transaction","detail":"{read_only:false; response_revision:25165; number_of_response:1; }","duration":"150.003044ms","start":"2026-07-21T07:32:20.546864Z","end":"2026-07-21T07:32:20.696867Z","steps":["trace[1713505806] 'process raft request'  (duration: 149.31997ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:20.929862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.77354ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098570310 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-manila.18c43da0d257c01c\" mod_revision:25065 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-manila.18c43da0d257c01c\" value_size:647 lease:1011514978098569552 >> failure:<request_range:<key:\"/registry/events/openstack/rabbitmq-manila.18c43da0d257c01c\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:32:20.929979Z","caller":"traceutil/trace.go:171","msg":"trace[1415079519] linearizableReadLoop","detail":"{readStateIndex:25978; appliedIndex:25977; }","duration":"212.233102ms","start":"2026-07-21T07:32:20.717728Z","end":"2026-07-21T07:32:20.929961Z","steps":["trace[1415079519] 'read index received'  (duration: 95.30744ms)","trace[1415079519] 'applied index is now lower than readState.Index'  (duration: 116.924292ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:20.930084Z","caller":"traceutil/trace.go:171","msg":"trace[1109210889] transaction","detail":"{read_only:false; response_revision:25166; number_of_response:1; }","duration":"215.858021ms","start":"2026-07-21T07:32:20.714211Z","end":"2026-07-21T07:32:20.930069Z","steps":["trace[1109210889] 'process raft request'  (duration: 98.769406ms)","trace[1109210889] 'compare'  (duration: 116.601996ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:20.930334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.797004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-07-21T07:32:20.930389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.65199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9648"}
{"level":"info","ts":"2026-07-21T07:32:20.930436Z","caller":"traceutil/trace.go:171","msg":"trace[530063896] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25166; }","duration":"212.720391ms","start":"2026-07-21T07:32:20.717704Z","end":"2026-07-21T07:32:20.930425Z","steps":["trace[530063896] 'agreement among raft nodes before linearized reading'  (duration: 212.573788ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:20.930494Z","caller":"traceutil/trace.go:171","msg":"trace[1931071483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25166; }","duration":"211.939807ms","start":"2026-07-21T07:32:20.718474Z","end":"2026-07-21T07:32:20.930414Z","steps":["trace[1931071483] 'agreement among raft nodes before linearized reading'  (duration: 211.59619ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:21.092545Z","caller":"traceutil/trace.go:171","msg":"trace[1529414078] linearizableReadLoop","detail":"{readStateIndex:25980; appliedIndex:25979; }","duration":"115.360452ms","start":"2026-07-21T07:32:20.977151Z","end":"2026-07-21T07:32:21.092511Z","steps":["trace[1529414078] 'read index received'  (duration: 102.14376ms)","trace[1529414078] 'applied index is now lower than readState.Index'  (duration: 13.215652ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:21.092633Z","caller":"traceutil/trace.go:171","msg":"trace[1938232825] transaction","detail":"{read_only:false; response_revision:25168; number_of_response:1; }","duration":"127.678399ms","start":"2026-07-21T07:32:20.964908Z","end":"2026-07-21T07:32:21.092586Z","steps":["trace[1938232825] 'process raft request'  (duration: 114.404205ms)","trace[1938232825] 'compare'  (duration: 13.019939ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:21.092809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.637237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9648"}
{"level":"info","ts":"2026-07-21T07:32:21.09286Z","caller":"traceutil/trace.go:171","msg":"trace[168461574] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25168; }","duration":"115.755319ms","start":"2026-07-21T07:32:20.977089Z","end":"2026-07-21T07:32:21.092845Z","steps":["trace[168461574] 'agreement among raft nodes before linearized reading'  (duration: 115.546656ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:21.394655Z","caller":"traceutil/trace.go:171","msg":"trace[1333468267] linearizableReadLoop","detail":"{readStateIndex:25981; appliedIndex:25980; }","duration":"288.958228ms","start":"2026-07-21T07:32:21.105673Z","end":"2026-07-21T07:32:21.394631Z","steps":["trace[1333468267] 'read index received'  (duration: 257.69518ms)","trace[1333468267] 'applied index is now lower than readState.Index'  (duration: 31.261908ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:21.394788Z","caller":"traceutil/trace.go:171","msg":"trace[916793038] transaction","detail":"{read_only:false; response_revision:25169; number_of_response:1; }","duration":"294.205838ms","start":"2026-07-21T07:32:21.100532Z","end":"2026-07-21T07:32:21.394737Z","steps":["trace[916793038] 'process raft request'  (duration: 262.95715ms)","trace[916793038] 'compare'  (duration: 30.804829ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-21T07:32:21.394956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.257133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10673"}
{"level":"info","ts":"2026-07-21T07:32:21.395004Z","caller":"traceutil/trace.go:171","msg":"trace[1441733310] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25169; }","duration":"289.344506ms","start":"2026-07-21T07:32:21.105648Z","end":"2026-07-21T07:32:21.394992Z","steps":["trace[1441733310] 'agreement among raft nodes before linearized reading'  (duration: 289.132602ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.394995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.081962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:32:21.395114Z","caller":"traceutil/trace.go:171","msg":"trace[294867836] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:25169; }","duration":"122.222164ms","start":"2026-07-21T07:32:21.272865Z","end":"2026-07-21T07:32:21.395088Z","steps":["trace[294867836] 'agreement among raft nodes before linearized reading'  (duration: 122.017821ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.395011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.267958ms","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-07-21T07:32:21.395197Z","caller":"traceutil/trace.go:171","msg":"trace[889309105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25169; }","duration":"272.496112ms","start":"2026-07-21T07:32:21.122686Z","end":"2026-07-21T07:32:21.395182Z","steps":["trace[889309105] 'agreement among raft nodes before linearized reading'  (duration: 272.125225ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.707857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.656205ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011514978098570323 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25149 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-21T07:32:21.708297Z","caller":"traceutil/trace.go:171","msg":"trace[1188614251] transaction","detail":"{read_only:false; response_revision:25170; number_of_response:1; }","duration":"308.256476ms","start":"2026-07-21T07:32:21.399998Z","end":"2026-07-21T07:32:21.708254Z","steps":["trace[1188614251] 'process raft request'  (duration: 168.11299ms)","trace[1188614251] 'compare'  (duration: 139.290959ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:21.708361Z","caller":"traceutil/trace.go:171","msg":"trace[714986377] linearizableReadLoop","detail":"{readStateIndex:25984; appliedIndex:25981; }","duration":"265.526819ms","start":"2026-07-21T07:32:21.442815Z","end":"2026-07-21T07:32:21.708341Z","steps":["trace[714986377] 'read index received'  (duration: 125.330483ms)","trace[714986377] 'applied index is now lower than readState.Index'  (duration: 140.177896ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:21.708454Z","caller":"traceutil/trace.go:171","msg":"trace[1958871493] transaction","detail":"{read_only:false; response_revision:25172; number_of_response:1; }","duration":"307.729265ms","start":"2026-07-21T07:32:21.400705Z","end":"2026-07-21T07:32:21.708434Z","steps":["trace[1958871493] 'process raft request'  (duration: 307.564382ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.708592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.747323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-21T07:32:21.708597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:21.400685Z","time spent":"307.803597ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25148 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-21T07:32:21.708633Z","caller":"traceutil/trace.go:171","msg":"trace[667551757] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:25172; }","duration":"265.861496ms","start":"2026-07-21T07:32:21.442758Z","end":"2026-07-21T07:32:21.70862Z","steps":["trace[667551757] 'agreement among raft nodes before linearized reading'  (duration: 265.698393ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:21.708598Z","caller":"traceutil/trace.go:171","msg":"trace[419548723] transaction","detail":"{read_only:false; response_revision:25171; number_of_response:1; }","duration":"307.719315ms","start":"2026-07-21T07:32:21.400626Z","end":"2026-07-21T07:32:21.708345Z","steps":["trace[419548723] 'process raft request'  (duration: 307.340387ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.708773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:21.39997Z","time spent":"308.409728ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25149 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-07-21T07:32:21.70873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.976094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:32:21.708862Z","caller":"traceutil/trace.go:171","msg":"trace[923328264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25172; }","duration":"239.141897ms","start":"2026-07-21T07:32:21.469692Z","end":"2026-07-21T07:32:21.708834Z","steps":["trace[923328264] 'agreement among raft nodes before linearized reading'  (duration: 238.859331ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.708617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.598065ms","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-07-21T07:32:21.709055Z","caller":"traceutil/trace.go:171","msg":"trace[696140681] 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:25172; }","duration":"240.119554ms","start":"2026-07-21T07:32:21.468922Z","end":"2026-07-21T07:32:21.709041Z","steps":["trace[696140681] 'agreement among raft nodes before linearized reading'  (duration: 239.585694ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:21.709372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T07:32:21.400612Z","time spent":"308.147723ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25147 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-07-21T07:32:22.094809Z","caller":"traceutil/trace.go:171","msg":"trace[2132490942] transaction","detail":"{read_only:false; response_revision:25174; number_of_response:1; }","duration":"117.026695ms","start":"2026-07-21T07:32:21.977762Z","end":"2026-07-21T07:32:22.094788Z","steps":["trace[2132490942] 'process raft request'  (duration: 114.66102ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:22.096831Z","caller":"traceutil/trace.go:171","msg":"trace[295352570] transaction","detail":"{read_only:false; response_revision:25175; number_of_response:1; }","duration":"102.624178ms","start":"2026-07-21T07:32:21.9942Z","end":"2026-07-21T07:32:22.096824Z","steps":["trace[295352570] 'process raft request'  (duration: 102.454775ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:23.712972Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006590.wal"}
{"level":"info","ts":"2026-07-21T07:32:25.916745Z","caller":"traceutil/trace.go:171","msg":"trace[866483784] transaction","detail":"{read_only:false; response_revision:25204; number_of_response:1; }","duration":"184.995063ms","start":"2026-07-21T07:32:25.731723Z","end":"2026-07-21T07:32:25.916718Z","steps":["trace[866483784] 'process raft request'  (duration: 184.923411ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:25.917011Z","caller":"traceutil/trace.go:171","msg":"trace[1763579284] transaction","detail":"{read_only:false; response_revision:25203; number_of_response:1; }","duration":"185.610934ms","start":"2026-07-21T07:32:25.731391Z","end":"2026-07-21T07:32:25.917002Z","steps":["trace[1763579284] 'process raft request'  (duration: 179.439816ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:26.689994Z","caller":"traceutil/trace.go:171","msg":"trace[1893322810] transaction","detail":"{read_only:false; response_revision:25213; number_of_response:1; }","duration":"122.094631ms","start":"2026-07-21T07:32:26.567871Z","end":"2026-07-21T07:32:26.689965Z","steps":["trace[1893322810] 'process raft request'  (duration: 121.882597ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:29.105977Z","caller":"traceutil/trace.go:171","msg":"trace[617202755] linearizableReadLoop","detail":"{readStateIndex:26043; appliedIndex:26042; }","duration":"112.140441ms","start":"2026-07-21T07:32:28.993808Z","end":"2026-07-21T07:32:29.105948Z","steps":["trace[617202755] 'read index received'  (duration: 102.186852ms)","trace[617202755] 'applied index is now lower than readState.Index'  (duration: 9.952409ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:29.106046Z","caller":"traceutil/trace.go:171","msg":"trace[599363058] transaction","detail":"{read_only:false; response_revision:25230; number_of_response:1; }","duration":"132.907887ms","start":"2026-07-21T07:32:28.973102Z","end":"2026-07-21T07:32:29.106009Z","steps":["trace[599363058] 'process raft request'  (duration: 122.806575ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:29.106139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.303574ms","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-07-21T07:32:29.106169Z","caller":"traceutil/trace.go:171","msg":"trace[1371741136] 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:25230; }","duration":"112.416176ms","start":"2026-07-21T07:32:28.993744Z","end":"2026-07-21T07:32:29.10616Z","steps":["trace[1371741136] 'agreement among raft nodes before linearized reading'  (duration: 112.319384ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:29.10626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.119795ms","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-07-21T07:32:29.10632Z","caller":"traceutil/trace.go:171","msg":"trace[1181684102] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:25230; }","duration":"106.219737ms","start":"2026-07-21T07:32:29.000086Z","end":"2026-07-21T07:32:29.106305Z","steps":["trace[1181684102] 'agreement among raft nodes before linearized reading'  (duration: 106.082694ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:30.431641Z","caller":"traceutil/trace.go:171","msg":"trace[817130881] transaction","detail":"{read_only:false; response_revision:25239; number_of_response:1; }","duration":"247.587108ms","start":"2026-07-21T07:32:30.184024Z","end":"2026-07-21T07:32:30.431611Z","steps":["trace[817130881] 'process raft request'  (duration: 223.284114ms)","trace[817130881] 'compare'  (duration: 24.057319ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:30.431979Z","caller":"traceutil/trace.go:171","msg":"trace[1093149001] transaction","detail":"{read_only:false; response_revision:25240; number_of_response:1; }","duration":"247.943445ms","start":"2026-07-21T07:32:30.184022Z","end":"2026-07-21T07:32:30.431965Z","steps":["trace[1093149001] 'process raft request'  (duration: 247.530057ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:30.43199Z","caller":"traceutil/trace.go:171","msg":"trace[1453008294] transaction","detail":"{read_only:false; response_revision:25241; number_of_response:1; }","duration":"247.361364ms","start":"2026-07-21T07:32:30.184606Z","end":"2026-07-21T07:32:30.431968Z","steps":["trace[1453008294] 'process raft request'  (duration: 247.205261ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:30.432089Z","caller":"traceutil/trace.go:171","msg":"trace[24023898] linearizableReadLoop","detail":"{readStateIndex:26056; appliedIndex:26052; }","duration":"167.306635ms","start":"2026-07-21T07:32:30.264755Z","end":"2026-07-21T07:32:30.432062Z","steps":["trace[24023898] 'read index received'  (duration: 142.571182ms)","trace[24023898] 'applied index is now lower than readState.Index'  (duration: 24.734153ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:30.432204Z","caller":"traceutil/trace.go:171","msg":"trace[1336957206] transaction","detail":"{read_only:false; response_revision:25242; number_of_response:1; }","duration":"245.684941ms","start":"2026-07-21T07:32:30.186487Z","end":"2026-07-21T07:32:30.432172Z","steps":["trace[1336957206] 'process raft request'  (duration: 245.434356ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:30.432273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.560967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:32:30.43231Z","caller":"traceutil/trace.go:171","msg":"trace[526672993] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25242; }","duration":"247.634098ms","start":"2026-07-21T07:32:30.184667Z","end":"2026-07-21T07:32:30.432301Z","steps":["trace[526672993] 'agreement among raft nodes before linearized reading'  (duration: 247.485456ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:30.432285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.834744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-07-21T07:32:30.432372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.424183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:32:30.432397Z","caller":"traceutil/trace.go:171","msg":"trace[1433160281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25242; }","duration":"223.999637ms","start":"2026-07-21T07:32:30.208372Z","end":"2026-07-21T07:32:30.432372Z","steps":["trace[1433160281] 'agreement among raft nodes before linearized reading'  (duration: 223.694031ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:30.432396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.664198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-21T07:32:30.432467Z","caller":"traceutil/trace.go:171","msg":"trace[779131811] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:25242; }","duration":"226.78481ms","start":"2026-07-21T07:32:30.205668Z","end":"2026-07-21T07:32:30.432453Z","steps":["trace[779131811] 'agreement among raft nodes before linearized reading'  (duration: 226.413453ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:30.432415Z","caller":"traceutil/trace.go:171","msg":"trace[1756471892] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25242; }","duration":"248.534385ms","start":"2026-07-21T07:32:30.18387Z","end":"2026-07-21T07:32:30.432404Z","steps":["trace[1756471892] 'agreement among raft nodes before linearized reading'  (duration: 248.344912ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:33.395872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.121673ms","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-07-21T07:32:33.396068Z","caller":"traceutil/trace.go:171","msg":"trace[549026218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25260; }","duration":"187.383457ms","start":"2026-07-21T07:32:33.208658Z","end":"2026-07-21T07:32:33.396041Z","steps":["trace[549026218] 'range keys from in-memory index tree'  (duration: 186.906678ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:33.396259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.238312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-07-21T07:32:33.396342Z","caller":"traceutil/trace.go:171","msg":"trace[46730411] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25260; }","duration":"224.393845ms","start":"2026-07-21T07:32:33.17193Z","end":"2026-07-21T07:32:33.396324Z","steps":["trace[46730411] 'range keys from in-memory index tree'  (duration: 224.062068ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:33.909237Z","caller":"traceutil/trace.go:171","msg":"trace[683722796] transaction","detail":"{read_only:false; response_revision:25262; number_of_response:1; }","duration":"113.982907ms","start":"2026-07-21T07:32:33.795222Z","end":"2026-07-21T07:32:33.909204Z","steps":["trace[683722796] 'process raft request'  (duration: 113.768973ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:34.111777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.892813ms","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-07-21T07:32:34.11188Z","caller":"traceutil/trace.go:171","msg":"trace[1858098523] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25262; }","duration":"160.010915ms","start":"2026-07-21T07:32:33.951844Z","end":"2026-07-21T07:32:34.111855Z","steps":["trace[1858098523] 'range keys from in-memory index tree'  (duration: 159.686819ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:34.111809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.222211ms","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-07-21T07:32:34.112023Z","caller":"traceutil/trace.go:171","msg":"trace[1986333123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25262; }","duration":"159.455665ms","start":"2026-07-21T07:32:33.952546Z","end":"2026-07-21T07:32:34.112002Z","steps":["trace[1986333123] 'range keys from in-memory index tree'  (duration: 159.108688ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:34.282133Z","caller":"traceutil/trace.go:171","msg":"trace[1764080359] transaction","detail":"{read_only:false; response_revision:25263; number_of_response:1; }","duration":"164.559602ms","start":"2026-07-21T07:32:34.117547Z","end":"2026-07-21T07:32:34.282107Z","steps":["trace[1764080359] 'process raft request'  (duration: 164.385839ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:34.29324Z","caller":"traceutil/trace.go:171","msg":"trace[292966996] transaction","detail":"{read_only:false; response_revision:25264; number_of_response:1; }","duration":"169.591999ms","start":"2026-07-21T07:32:34.1236Z","end":"2026-07-21T07:32:34.293192Z","steps":["trace[292966996] 'process raft request'  (duration: 169.254702ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:34.293617Z","caller":"traceutil/trace.go:171","msg":"trace[132970238] linearizableReadLoop","detail":"{readStateIndex:26080; appliedIndex:26077; }","duration":"131.737125ms","start":"2026-07-21T07:32:34.161864Z","end":"2026-07-21T07:32:34.293601Z","steps":["trace[132970238] 'read index received'  (duration: 120.42776ms)","trace[132970238] 'applied index is now lower than readState.Index'  (duration: 11.308295ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:32:34.29367Z","caller":"traceutil/trace.go:171","msg":"trace[184100405] transaction","detail":"{read_only:false; response_revision:25266; number_of_response:1; }","duration":"147.080428ms","start":"2026-07-21T07:32:34.146548Z","end":"2026-07-21T07:32:34.293629Z","steps":["trace[184100405] 'process raft request'  (duration: 146.792212ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:32:34.293887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.011901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7698"}
{"level":"info","ts":"2026-07-21T07:32:34.293928Z","caller":"traceutil/trace.go:171","msg":"trace[145914530] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:25267; }","duration":"132.123693ms","start":"2026-07-21T07:32:34.161791Z","end":"2026-07-21T07:32:34.293915Z","steps":["trace[145914530] 'agreement among raft nodes before linearized reading'  (duration: 131.927189ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:32:34.293464Z","caller":"traceutil/trace.go:171","msg":"trace[1908630294] transaction","detail":"{read_only:false; response_revision:25265; number_of_response:1; }","duration":"147.143139ms","start":"2026-07-21T07:32:34.146267Z","end":"2026-07-21T07:32:34.29341Z","steps":["trace[1908630294] 'process raft request'  (duration: 146.751211ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.788361Z","caller":"traceutil/trace.go:171","msg":"trace[999811311] linearizableReadLoop","detail":"{readStateIndex:26488; appliedIndex:26486; }","duration":"287.233435ms","start":"2026-07-21T07:33:08.501078Z","end":"2026-07-21T07:33:08.788312Z","steps":["trace[999811311] 'read index received'  (duration: 36.042768ms)","trace[999811311] 'applied index is now lower than readState.Index'  (duration: 251.188866ms)"],"step_count":2}
{"level":"info","ts":"2026-07-21T07:33:08.788443Z","caller":"traceutil/trace.go:171","msg":"trace[821520574] transaction","detail":"{read_only:false; response_revision:25666; number_of_response:1; }","duration":"286.951239ms","start":"2026-07-21T07:33:08.501457Z","end":"2026-07-21T07:33:08.788408Z","steps":["trace[821520574] 'process raft request'  (duration: 286.794586ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.788412Z","caller":"traceutil/trace.go:171","msg":"trace[490980303] transaction","detail":"{read_only:false; response_revision:25665; number_of_response:1; }","duration":"290.209331ms","start":"2026-07-21T07:33:08.498139Z","end":"2026-07-21T07:33:08.788349Z","steps":["trace[490980303] 'process raft request'  (duration: 289.881545ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:33:08.788635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.52165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-21T07:33:08.788749Z","caller":"traceutil/trace.go:171","msg":"trace[1561299927] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:25666; }","duration":"287.698073ms","start":"2026-07-21T07:33:08.501022Z","end":"2026-07-21T07:33:08.78872Z","steps":["trace[1561299927] 'agreement among raft nodes before linearized reading'  (duration: 287.450889ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.803729Z","caller":"traceutil/trace.go:171","msg":"trace[325466940] transaction","detail":"{read_only:false; response_revision:25667; number_of_response:1; }","duration":"234.944756ms","start":"2026-07-21T07:33:08.568756Z","end":"2026-07-21T07:33:08.803701Z","steps":["trace[325466940] 'process raft request'  (duration: 234.663081ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.804092Z","caller":"traceutil/trace.go:171","msg":"trace[2008886920] transaction","detail":"{read_only:false; response_revision:25668; number_of_response:1; }","duration":"219.954769ms","start":"2026-07-21T07:33:08.583859Z","end":"2026-07-21T07:33:08.803814Z","steps":["trace[2008886920] 'process raft request'  (duration: 219.743935ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.804624Z","caller":"traceutil/trace.go:171","msg":"trace[1114123043] transaction","detail":"{read_only:false; response_revision:25669; number_of_response:1; }","duration":"219.461521ms","start":"2026-07-21T07:33:08.585142Z","end":"2026-07-21T07:33:08.804604Z","steps":["trace[1114123043] 'process raft request'  (duration: 218.531953ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.804839Z","caller":"traceutil/trace.go:171","msg":"trace[773533951] transaction","detail":"{read_only:false; response_revision:25670; number_of_response:1; }","duration":"217.522474ms","start":"2026-07-21T07:33:08.587167Z","end":"2026-07-21T07:33:08.80469Z","steps":["trace[773533951] 'process raft request'  (duration: 217.296918ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:33:08.804951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.039043ms","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-07-21T07:33:08.80485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.78132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:33:08.805008Z","caller":"traceutil/trace.go:171","msg":"trace[458244603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25670; }","duration":"240.147255ms","start":"2026-07-21T07:33:08.564848Z","end":"2026-07-21T07:33:08.804995Z","steps":["trace[458244603] 'agreement among raft nodes before linearized reading'  (duration: 239.987392ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:33:08.805036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.408597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-07-21T07:33:08.804953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.962882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-07-21T07:33:08.805073Z","caller":"traceutil/trace.go:171","msg":"trace[1874034758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25670; }","duration":"101.506288ms","start":"2026-07-21T07:33:08.703556Z","end":"2026-07-21T07:33:08.805062Z","steps":["trace[1874034758] 'agreement among raft nodes before linearized reading'  (duration: 101.425377ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-21T07:33:08.804962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.648277ms","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-07-21T07:33:08.805205Z","caller":"traceutil/trace.go:171","msg":"trace[1462855707] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25670; }","duration":"281.935114ms","start":"2026-07-21T07:33:08.523245Z","end":"2026-07-21T07:33:08.80518Z","steps":["trace[1462855707] 'agreement among raft nodes before linearized reading'  (duration: 281.659119ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.805356Z","caller":"traceutil/trace.go:171","msg":"trace[720001121] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25670; }","duration":"249.029405ms","start":"2026-07-21T07:33:08.555993Z","end":"2026-07-21T07:33:08.805023Z","steps":["trace[720001121] 'agreement among raft nodes before linearized reading'  (duration: 248.694538ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:08.805796Z","caller":"traceutil/trace.go:171","msg":"trace[1422562046] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:25670; }","duration":"240.237177ms","start":"2026-07-21T07:33:08.564835Z","end":"2026-07-21T07:33:08.805072Z","steps":["trace[1422562046] 'agreement among raft nodes before linearized reading'  (duration: 239.948221ms)"],"step_count":1}
{"level":"info","ts":"2026-07-21T07:33:46.195732Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23027}
{"level":"info","ts":"2026-07-21T07:33:46.328684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23027,"took":"127.772919ms","hash":816129318,"current-db-size-bytes":59494400,"current-db-size":"60 MB","current-db-size-in-use-bytes":36163584,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-07-21T07:33:46.328788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":816129318,"revision":23027,"compact-revision":20033}
{"level":"info","ts":"2026-07-21T07:38:46.200889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25980}
{"level":"info","ts":"2026-07-21T07:38:46.338912Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25980,"took":"131.915657ms","hash":1319608998,"current-db-size-bytes":59494400,"current-db-size":"60 MB","current-db-size-in-use-bytes":32661504,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-07-21T07:38:46.338974Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1319608998,"revision":25980,"compact-revision":23027}