{"level":"warn","ts":"2026-03-20T10:12:53.117516Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T10:12:53.117615Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-03-20T10:12:53.117757Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T10:12:53.117767Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-03-20T10:12:53.117791Z","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-03-20T10:12:53.11845Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]}
{"level":"info","ts":"2026-03-20T10:12:53.118524Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-03-20T10:12:53.122095Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.358844ms"}
{"level":"info","ts":"2026-03-20T10:12:53.127657Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"}
{"level":"info","ts":"2026-03-20T10:12:53.127741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T10:12:53.127768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"}
{"level":"info","ts":"2026-03-20T10:12:53.127782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T10:12:53.127796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"}
{"level":"info","ts":"2026-03-20T10:12:53.127842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"warn","ts":"2026-03-20T10:12:53.132091Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T10:12:53.133662Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T10:12:53.13511Z","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-03-20T10:12:53.138034Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T10:12:53.138777Z","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-03-20T10:12:53.138418Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T10:12:53.139365Z","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-03-20T10:12:53.139419Z","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-03-20T10:12:53.140627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"info","ts":"2026-03-20T10:12:53.14141Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-03-20T10:12:53.143201Z","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-03-20T10:12:53.143308Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-03-20T10:12:53.143363Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-03-20T10:12:53.143508Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T10:12:53.143542Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T10:12:53.62841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T10:12:53.6285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T10:12:53.628532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"}
{"level":"info","ts":"2026-03-20T10:12:53.62855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"}
{"level":"info","ts":"2026-03-20T10:12:53.62856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-03-20T10:12:53.628573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"}
{"level":"info","ts":"2026-03-20T10:12:53.628585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-03-20T10:12:53.629747Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:53.6304Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T10:12:53.630451Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:12:53.630532Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:12:53.630827Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:53.630873Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T10:12:53.630935Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T10:12:53.630954Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:53.631008Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:12:53.63377Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"}
{"level":"info","ts":"2026-03-20T10:12:53.634028Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-20T10:13:21.907094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.383845ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164648746 > lease_revoke:<id:38e19d0abbcd0a5b>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:13:28.771225Z","caller":"traceutil/trace.go:171","msg":"trace[1201466957] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"323.846335ms","start":"2026-03-20T10:13:28.447347Z","end":"2026-03-20T10:13:28.771194Z","steps":["trace[1201466957] 'process raft request'  (duration: 323.59395ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:13:28.771863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:13:28.447319Z","time spent":"324.004978ms","remote":"127.0.0.1:50002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-v8rtl\" mod_revision:458 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-v8rtl\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-v8rtl\" > >"}
{"level":"info","ts":"2026-03-20T10:14:32.537619Z","caller":"traceutil/trace.go:171","msg":"trace[753395301] transaction","detail":"{read_only:false; response_revision:1531; number_of_response:1; }","duration":"159.991097ms","start":"2026-03-20T10:14:32.377596Z","end":"2026-03-20T10:14:32.537587Z","steps":["trace[753395301] 'process raft request'  (duration: 159.764483ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:22.276205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.98634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-20T10:15:22.276231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.876558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-20T10:15:22.276285Z","caller":"traceutil/trace.go:171","msg":"trace[1403370180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1821; }","duration":"111.096691ms","start":"2026-03-20T10:15:22.165168Z","end":"2026-03-20T10:15:22.276264Z","steps":["trace[1403370180] 'range keys from in-memory index tree'  (duration: 110.833207ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:22.276328Z","caller":"traceutil/trace.go:171","msg":"trace[452625753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1821; }","duration":"110.011931ms","start":"2026-03-20T10:15:22.166285Z","end":"2026-03-20T10:15:22.276297Z","steps":["trace[452625753] 'range keys from in-memory index tree'  (duration: 109.703905ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:22.422852Z","caller":"traceutil/trace.go:171","msg":"trace[1142762597] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"142.694939ms","start":"2026-03-20T10:15:22.280118Z","end":"2026-03-20T10:15:22.422813Z","steps":["trace[1142762597] 'process raft request'  (duration: 142.396783ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:22.472083Z","caller":"traceutil/trace.go:171","msg":"trace[1456244506] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1894; }","duration":"166.249206ms","start":"2026-03-20T10:15:22.305809Z","end":"2026-03-20T10:15:22.472058Z","steps":["trace[1456244506] 'read index received'  (duration: 116.710034ms)","trace[1456244506] 'applied index is now lower than readState.Index'  (duration: 49.538302ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:15:22.472128Z","caller":"traceutil/trace.go:171","msg":"trace[280432231] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"191.941556ms","start":"2026-03-20T10:15:22.280159Z","end":"2026-03-20T10:15:22.4721Z","steps":["trace[280432231] 'process raft request'  (duration: 191.742242ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:15:22.4722Z","caller":"traceutil/trace.go:171","msg":"trace[592852917] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"191.399435ms","start":"2026-03-20T10:15:22.28076Z","end":"2026-03-20T10:15:22.472159Z","steps":["trace[592852917] 'process raft request'  (duration: 191.252862ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:15:22.472358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.536391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T10:15:22.472409Z","caller":"traceutil/trace.go:171","msg":"trace[1448069564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1824; }","duration":"166.640183ms","start":"2026-03-20T10:15:22.305753Z","end":"2026-03-20T10:15:22.472393Z","steps":["trace[1448069564] 'agreement among raft nodes before linearized reading'  (duration: 166.387899ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:36.631476Z","caller":"traceutil/trace.go:171","msg":"trace[2144884219] transaction","detail":"{read_only:false; response_revision:2383; number_of_response:1; }","duration":"128.297015ms","start":"2026-03-20T10:16:36.503158Z","end":"2026-03-20T10:16:36.631455Z","steps":["trace[2144884219] 'process raft request'  (duration: 127.779964ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:37.075229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.451257ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164652876 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2375 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:16:37.075337Z","caller":"traceutil/trace.go:171","msg":"trace[1854414272] linearizableReadLoop","detail":"{readStateIndex:2481; appliedIndex:2480; }","duration":"266.493747ms","start":"2026-03-20T10:16:36.808827Z","end":"2026-03-20T10:16:37.075321Z","steps":["trace[1854414272] 'read index received'  (duration: 26.931367ms)","trace[1854414272] 'applied index is now lower than readState.Index'  (duration: 239.56102ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:16:37.075405Z","caller":"traceutil/trace.go:171","msg":"trace[1254639150] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"294.452763ms","start":"2026-03-20T10:16:36.780938Z","end":"2026-03-20T10:16:37.07539Z","steps":["trace[1254639150] 'process raft request'  (duration: 54.759341ms)","trace[1254639150] 'compare'  (duration: 239.322785ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:16:37.075868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.003637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T10:16:37.075968Z","caller":"traceutil/trace.go:171","msg":"trace[1272899740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2385; }","duration":"267.154261ms","start":"2026-03-20T10:16:36.808787Z","end":"2026-03-20T10:16:37.075941Z","steps":["trace[1272899740] 'agreement among raft nodes before linearized reading'  (duration: 266.686851ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:37.097779Z","caller":"traceutil/trace.go:171","msg":"trace[1318919361] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"136.544528ms","start":"2026-03-20T10:16:36.961204Z","end":"2026-03-20T10:16:37.097748Z","steps":["trace[1318919361] 'process raft request'  (duration: 136.313344ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:16:37.097908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.856772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-20T10:16:37.097985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.916063ms","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-03-20T10:16:37.098061Z","caller":"traceutil/trace.go:171","msg":"trace[1613875767] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2386; }","duration":"287.013945ms","start":"2026-03-20T10:16:36.811025Z","end":"2026-03-20T10:16:37.098039Z","steps":["trace[1613875767] 'agreement among raft nodes before linearized reading'  (duration: 286.77614ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:37.098055Z","caller":"traceutil/trace.go:171","msg":"trace[1958101286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2386; }","duration":"288.003154ms","start":"2026-03-20T10:16:36.810006Z","end":"2026-03-20T10:16:37.098009Z","steps":["trace[1958101286] 'agreement among raft nodes before linearized reading'  (duration: 287.667698ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:37.249253Z","caller":"traceutil/trace.go:171","msg":"trace[2116544961] transaction","detail":"{read_only:false; response_revision:2387; number_of_response:1; }","duration":"168.768401ms","start":"2026-03-20T10:16:37.080457Z","end":"2026-03-20T10:16:37.249225Z","steps":["trace[2116544961] 'process raft request'  (duration: 164.153479ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:37.249461Z","caller":"traceutil/trace.go:171","msg":"trace[479277271] transaction","detail":"{read_only:false; response_revision:2388; number_of_response:1; }","duration":"147.590639ms","start":"2026-03-20T10:16:37.101846Z","end":"2026-03-20T10:16:37.249437Z","steps":["trace[479277271] 'process raft request'  (duration: 147.339064ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:37.24954Z","caller":"traceutil/trace.go:171","msg":"trace[954893983] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"147.051738ms","start":"2026-03-20T10:16:37.102452Z","end":"2026-03-20T10:16:37.249504Z","steps":["trace[954893983] 'process raft request'  (duration: 146.892505ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:16:42.390932Z","caller":"traceutil/trace.go:171","msg":"trace[155774099] transaction","detail":"{read_only:false; response_revision:2413; number_of_response:1; }","duration":"100.033832ms","start":"2026-03-20T10:16:42.290871Z","end":"2026-03-20T10:16:42.390905Z","steps":["trace[155774099] 'process raft request'  (duration: 80.160266ms)","trace[155774099] 'compare'  (duration: 19.765904ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:19:02.302517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.884522ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164655331 > lease_revoke:<id:38e19d0abbcd23ed>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:19:29.478112Z","caller":"traceutil/trace.go:171","msg":"trace[1697072318] transaction","detail":"{read_only:false; response_revision:3429; number_of_response:1; }","duration":"150.586687ms","start":"2026-03-20T10:19:29.32749Z","end":"2026-03-20T10:19:29.478076Z","steps":["trace[1697072318] 'process raft request'  (duration: 150.404774ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:36.586157Z","caller":"traceutil/trace.go:171","msg":"trace[619259014] transaction","detail":"{read_only:false; response_revision:3520; number_of_response:1; }","duration":"149.853652ms","start":"2026-03-20T10:19:36.436277Z","end":"2026-03-20T10:19:36.58613Z","steps":["trace[619259014] 'process raft request'  (duration: 149.798801ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:36.586188Z","caller":"traceutil/trace.go:171","msg":"trace[1076225851] linearizableReadLoop","detail":"{readStateIndex:3660; appliedIndex:3659; }","duration":"154.463574ms","start":"2026-03-20T10:19:36.431687Z","end":"2026-03-20T10:19:36.586151Z","steps":["trace[1076225851] 'read index received'  (duration: 78.296383ms)","trace[1076225851] 'applied index is now lower than readState.Index'  (duration: 76.16417ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:19:36.586409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.467978ms","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-03-20T10:19:36.586447Z","caller":"traceutil/trace.go:171","msg":"trace[1036865126] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3520; }","duration":"188.57206ms","start":"2026-03-20T10:19:36.39786Z","end":"2026-03-20T10:19:36.586432Z","steps":["trace[1036865126] 'agreement among raft nodes before linearized reading'  (duration: 188.396647ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:19:36.586425Z","caller":"traceutil/trace.go:171","msg":"trace[2086005369] transaction","detail":"{read_only:false; response_revision:3519; number_of_response:1; }","duration":"179.008111ms","start":"2026-03-20T10:19:36.40738Z","end":"2026-03-20T10:19:36.586388Z","steps":["trace[2086005369] 'process raft request'  (duration: 102.594046ms)","trace[2086005369] 'compare'  (duration: 75.913295ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:19:37.021365Z","caller":"traceutil/trace.go:171","msg":"trace[395931855] transaction","detail":"{read_only:false; response_revision:3526; number_of_response:1; }","duration":"190.53868ms","start":"2026-03-20T10:19:36.830809Z","end":"2026-03-20T10:19:37.021347Z","steps":["trace[395931855] 'process raft request'  (duration: 124.752545ms)","trace[395931855] 'compare'  (duration: 65.168013ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:19:39.157901Z","caller":"traceutil/trace.go:171","msg":"trace[530503270] transaction","detail":"{read_only:false; response_revision:3539; number_of_response:1; }","duration":"106.594625ms","start":"2026-03-20T10:19:39.051285Z","end":"2026-03-20T10:19:39.157879Z","steps":["trace[530503270] 'process raft request'  (duration: 35.560286ms)","trace[530503270] 'compare'  (duration: 70.670972ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:20:26.7428Z","caller":"traceutil/trace.go:171","msg":"trace[522667689] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"215.95307ms","start":"2026-03-20T10:20:26.526823Z","end":"2026-03-20T10:20:26.742776Z","steps":["trace[522667689] 'process raft request'  (duration: 215.796487ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:26.879829Z","caller":"traceutil/trace.go:171","msg":"trace[518452853] transaction","detail":"{read_only:false; response_revision:4425; number_of_response:1; }","duration":"306.600805ms","start":"2026-03-20T10:20:26.573207Z","end":"2026-03-20T10:20:26.879808Z","steps":["trace[518452853] 'process raft request'  (duration: 244.661912ms)","trace[518452853] 'compare'  (duration: 61.652257ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:20:26.879965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:20:26.573181Z","time spent":"306.709867ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:4087 > 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-03-20T10:20:26.879757Z","caller":"traceutil/trace.go:171","msg":"trace[1865619179] linearizableReadLoop","detail":"{readStateIndex:4600; appliedIndex:4598; }","duration":"259.831944ms","start":"2026-03-20T10:20:26.619899Z","end":"2026-03-20T10:20:26.879731Z","steps":["trace[1865619179] 'read index received'  (duration: 122.850186ms)","trace[1865619179] 'applied index is now lower than readState.Index'  (duration: 136.980838ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:20:26.880083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.16479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-20T10:20:26.880159Z","caller":"traceutil/trace.go:171","msg":"trace[774525732] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4425; }","duration":"260.279173ms","start":"2026-03-20T10:20:26.619861Z","end":"2026-03-20T10:20:26.88014Z","steps":["trace[774525732] 'agreement among raft nodes before linearized reading'  (duration: 260.061968ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:20:26.881963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.170162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-20T10:20:26.882012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.237364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-20T10:20:26.882012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.637327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-104c8963-a0a4-4166-af8b-304cd0f7d3c2\" ","response":"range_response_count:1 size:3717"}
{"level":"info","ts":"2026-03-20T10:20:26.88204Z","caller":"traceutil/trace.go:171","msg":"trace[1044288855] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:4426; }","duration":"130.294054ms","start":"2026-03-20T10:20:26.751728Z","end":"2026-03-20T10:20:26.882022Z","steps":["trace[1044288855] 'agreement among raft nodes before linearized reading'  (duration: 130.118841ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:26.882078Z","caller":"traceutil/trace.go:171","msg":"trace[2134536461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4426; }","duration":"251.322175ms","start":"2026-03-20T10:20:26.630738Z","end":"2026-03-20T10:20:26.88206Z","steps":["trace[2134536461] 'agreement among raft nodes before linearized reading'  (duration: 251.07388ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:26.882085Z","caller":"traceutil/trace.go:171","msg":"trace[1581550257] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-104c8963-a0a4-4166-af8b-304cd0f7d3c2; range_end:; response_count:1; response_revision:4426; }","duration":"185.744008ms","start":"2026-03-20T10:20:26.696324Z","end":"2026-03-20T10:20:26.882068Z","steps":["trace[1581550257] 'agreement among raft nodes before linearized reading'  (duration: 185.571555ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:26.882348Z","caller":"traceutil/trace.go:171","msg":"trace[508602946] transaction","detail":"{read_only:false; response_revision:4426; number_of_response:1; }","duration":"127.908196ms","start":"2026-03-20T10:20:26.754427Z","end":"2026-03-20T10:20:26.882335Z","steps":["trace[508602946] 'process raft request'  (duration: 127.297415ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:20:26.882392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.191102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-20T10:20:26.882443Z","caller":"traceutil/trace.go:171","msg":"trace[591028061] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:4426; }","duration":"240.267694ms","start":"2026-03-20T10:20:26.64216Z","end":"2026-03-20T10:20:26.882428Z","steps":["trace[591028061] 'agreement among raft nodes before linearized reading'  (duration: 240.133852ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:34.809174Z","caller":"traceutil/trace.go:171","msg":"trace[581885266] transaction","detail":"{read_only:false; response_revision:4569; number_of_response:1; }","duration":"168.976054ms","start":"2026-03-20T10:20:34.640171Z","end":"2026-03-20T10:20:34.809147Z","steps":["trace[581885266] 'process raft request'  (duration: 88.967051ms)","trace[581885266] 'compare'  (duration: 79.697157ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:20:34.86285Z","caller":"traceutil/trace.go:171","msg":"trace[1674066205] transaction","detail":"{read_only:false; response_revision:4570; number_of_response:1; }","duration":"222.51444ms","start":"2026-03-20T10:20:34.64031Z","end":"2026-03-20T10:20:34.862824Z","steps":["trace[1674066205] 'process raft request'  (duration: 222.310896ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:34.863162Z","caller":"traceutil/trace.go:171","msg":"trace[538157610] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"222.585922ms","start":"2026-03-20T10:20:34.640553Z","end":"2026-03-20T10:20:34.863139Z","steps":["trace[538157610] 'process raft request'  (duration: 222.222485ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:34.863466Z","caller":"traceutil/trace.go:171","msg":"trace[2013153473] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"222.806307ms","start":"2026-03-20T10:20:34.640652Z","end":"2026-03-20T10:20:34.863458Z","steps":["trace[2013153473] 'process raft request'  (duration: 222.369788ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:35.15527Z","caller":"traceutil/trace.go:171","msg":"trace[1565744890] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"106.43194ms","start":"2026-03-20T10:20:35.048806Z","end":"2026-03-20T10:20:35.155238Z","steps":["trace[1565744890] 'process raft request'  (duration: 100.576763ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:20:35.157617Z","caller":"traceutil/trace.go:171","msg":"trace[1260572861] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"106.178204ms","start":"2026-03-20T10:20:35.051415Z","end":"2026-03-20T10:20:35.157594Z","steps":["trace[1260572861] 'process raft request'  (duration: 106.00656ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:00.989498Z","caller":"traceutil/trace.go:171","msg":"trace[2043133982] linearizableReadLoop","detail":"{readStateIndex:5136; appliedIndex:5135; }","duration":"105.757445ms","start":"2026-03-20T10:21:00.883716Z","end":"2026-03-20T10:21:00.989473Z","steps":["trace[2043133982] 'read index received'  (duration: 105.563031ms)","trace[2043133982] 'applied index is now lower than readState.Index'  (duration: 193.314µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:21:00.989781Z","caller":"traceutil/trace.go:171","msg":"trace[37739936] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"118.713054ms","start":"2026-03-20T10:21:00.87103Z","end":"2026-03-20T10:21:00.989743Z","steps":["trace[37739936] 'process raft request'  (duration: 118.270924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:00.989901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.170285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-03-20T10:21:00.990021Z","caller":"traceutil/trace.go:171","msg":"trace[2123029594] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4947; }","duration":"106.281547ms","start":"2026-03-20T10:21:00.883697Z","end":"2026-03-20T10:21:00.989978Z","steps":["trace[2123029594] 'agreement among raft nodes before linearized reading'  (duration: 105.947199ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.601743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.398501ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164659163 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-vb8g2\" mod_revision:4670 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-vb8g2\" value_size:1362 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-vb8g2\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:21:01.602041Z","caller":"traceutil/trace.go:171","msg":"trace[347151426] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"605.887385ms","start":"2026-03-20T10:21:00.99612Z","end":"2026-03-20T10:21:01.602007Z","steps":["trace[347151426] 'process raft request'  (duration: 292.062355ms)","trace[347151426] 'compare'  (duration: 313.176597ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:21:01.602389Z","caller":"traceutil/trace.go:171","msg":"trace[2023863622] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"605.482777ms","start":"2026-03-20T10:21:00.996882Z","end":"2026-03-20T10:21:01.602365Z","steps":["trace[2023863622] 'process raft request'  (duration: 605.326894ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.602411Z","caller":"traceutil/trace.go:171","msg":"trace[943212225] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"605.836374ms","start":"2026-03-20T10:21:00.996524Z","end":"2026-03-20T10:21:01.60236Z","steps":["trace[943212225] 'process raft request'  (duration: 605.343024ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.602472Z","caller":"traceutil/trace.go:171","msg":"trace[681603008] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"603.071059ms","start":"2026-03-20T10:21:00.99935Z","end":"2026-03-20T10:21:01.602421Z","steps":["trace[681603008] 'process raft request'  (duration: 602.951066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.602519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:00.996874Z","time spent":"605.572939ms","remote":"127.0.0.1:50088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-29725\" mod_revision:4664 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-29725\" value_size:1433 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-29725\" > >"}
{"level":"warn","ts":"2026-03-20T10:21:01.602489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:00.996104Z","time spent":"606.256643ms","remote":"127.0.0.1:50088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-vb8g2\" mod_revision:4670 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-vb8g2\" value_size:1362 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-vb8g2\" > >"}
{"level":"info","ts":"2026-03-20T10:21:01.602538Z","caller":"traceutil/trace.go:171","msg":"trace[877455774] linearizableReadLoop","detail":"{readStateIndex:5141; appliedIndex:5136; }","duration":"551.533653ms","start":"2026-03-20T10:21:01.050981Z","end":"2026-03-20T10:21:01.602514Z","steps":["trace[877455774] 'read index received'  (duration: 237.215104ms)","trace[877455774] 'applied index is now lower than readState.Index'  (duration: 314.313008ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:21:01.602565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:00.996504Z","time spent":"605.974997ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4663 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:880 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"warn","ts":"2026-03-20T10:21:01.602609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:00.999343Z","time spent":"603.192301ms","remote":"127.0.0.1:50002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4142,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-2p8cq\" mod_revision:4796 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-2p8cq\" value_size:4069 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-2p8cq\" > >"}
{"level":"info","ts":"2026-03-20T10:21:01.60265Z","caller":"traceutil/trace.go:171","msg":"trace[235116836] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"605.537758ms","start":"2026-03-20T10:21:00.997088Z","end":"2026-03-20T10:21:01.602626Z","steps":["trace[235116836] 'process raft request'  (duration: 605.174681ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.602769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.776667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2319"}
{"level":"warn","ts":"2026-03-20T10:21:01.602768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:00.997072Z","time spent":"605.63538ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4668 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:828 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"info","ts":"2026-03-20T10:21:01.602827Z","caller":"traceutil/trace.go:171","msg":"trace[1702699685] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4952; }","duration":"551.874169ms","start":"2026-03-20T10:21:01.050936Z","end":"2026-03-20T10:21:01.60281Z","steps":["trace[1702699685] 'agreement among raft nodes before linearized reading'  (duration: 551.687856ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.602872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:01.050917Z","time spent":"551.941951ms","remote":"127.0.0.1:45040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":2342,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" "}
{"level":"warn","ts":"2026-03-20T10:21:01.639366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.426927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-03-20T10:21:01.639455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.047927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-20T10:21:01.639501Z","caller":"traceutil/trace.go:171","msg":"trace[687953149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4953; }","duration":"503.127769ms","start":"2026-03-20T10:21:01.136361Z","end":"2026-03-20T10:21:01.639489Z","steps":["trace[687953149] 'agreement among raft nodes before linearized reading'  (duration: 503.036057ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.639547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:01.136338Z","time spent":"503.20024ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-20T10:21:01.63948Z","caller":"traceutil/trace.go:171","msg":"trace[1085615174] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4953; }","duration":"471.58468ms","start":"2026-03-20T10:21:01.167877Z","end":"2026-03-20T10:21:01.639462Z","steps":["trace[1085615174] 'agreement among raft nodes before linearized reading'  (duration: 471.356336ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.639643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:21:01.167858Z","time spent":"471.774835ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-20T10:21:01.639366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.749441ms","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-03-20T10:21:01.639785Z","caller":"traceutil/trace.go:171","msg":"trace[866627889] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4953; }","duration":"268.231181ms","start":"2026-03-20T10:21:01.371539Z","end":"2026-03-20T10:21:01.63977Z","steps":["trace[866627889] 'agreement among raft nodes before linearized reading'  (duration: 267.68663ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.639725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.855212ms","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-03-20T10:21:01.639946Z","caller":"traceutil/trace.go:171","msg":"trace[1216688801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4953; }","duration":"280.110028ms","start":"2026-03-20T10:21:01.359825Z","end":"2026-03-20T10:21:01.639935Z","steps":["trace[1216688801] 'agreement among raft nodes before linearized reading'  (duration: 279.834742ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.639864Z","caller":"traceutil/trace.go:171","msg":"trace[564510106] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"268.411575ms","start":"2026-03-20T10:21:01.37144Z","end":"2026-03-20T10:21:01.639852Z","steps":["trace[564510106] 'process raft request'  (duration: 267.636569ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.765349Z","caller":"traceutil/trace.go:171","msg":"trace[121165412] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"157.057817ms","start":"2026-03-20T10:21:01.608265Z","end":"2026-03-20T10:21:01.765323Z","steps":["trace[121165412] 'process raft request'  (duration: 112.217355ms)","trace[121165412] 'compare'  (duration: 44.642889ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:21:01.765568Z","caller":"traceutil/trace.go:171","msg":"trace[517366622] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"157.19254ms","start":"2026-03-20T10:21:01.608363Z","end":"2026-03-20T10:21:01.765556Z","steps":["trace[517366622] 'process raft request'  (duration: 156.901394ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.765733Z","caller":"traceutil/trace.go:171","msg":"trace[903645727] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"155.594199ms","start":"2026-03-20T10:21:01.61012Z","end":"2026-03-20T10:21:01.765714Z","steps":["trace[903645727] 'process raft request'  (duration: 155.365104ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.765728Z","caller":"traceutil/trace.go:171","msg":"trace[224619172] linearizableReadLoop","detail":"{readStateIndex:5145; appliedIndex:5142; }","duration":"126.464568ms","start":"2026-03-20T10:21:01.639204Z","end":"2026-03-20T10:21:01.765669Z","steps":["trace[224619172] 'read index received'  (duration: 81.385081ms)","trace[224619172] 'applied index is now lower than readState.Index'  (duration: 45.077037ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:21:01.765937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.952606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4792"}
{"level":"info","ts":"2026-03-20T10:21:01.765972Z","caller":"traceutil/trace.go:171","msg":"trace[774356163] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4956; }","duration":"156.025127ms","start":"2026-03-20T10:21:01.609936Z","end":"2026-03-20T10:21:01.765961Z","steps":["trace[774356163] 'agreement among raft nodes before linearized reading'  (duration: 155.865824ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.770802Z","caller":"traceutil/trace.go:171","msg":"trace[301759285] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"126.511989ms","start":"2026-03-20T10:21:01.644276Z","end":"2026-03-20T10:21:01.770788Z","steps":["trace[301759285] 'process raft request'  (duration: 126.398447ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.770967Z","caller":"traceutil/trace.go:171","msg":"trace[297950141] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"126.517139ms","start":"2026-03-20T10:21:01.644441Z","end":"2026-03-20T10:21:01.770958Z","steps":["trace[297950141] 'process raft request'  (duration: 126.315755ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.771226Z","caller":"traceutil/trace.go:171","msg":"trace[2026274654] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"126.58552ms","start":"2026-03-20T10:21:01.644623Z","end":"2026-03-20T10:21:01.771209Z","steps":["trace[2026274654] 'process raft request'  (duration: 126.302245ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:21:01.771439Z","caller":"traceutil/trace.go:171","msg":"trace[683965968] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"126.597852ms","start":"2026-03-20T10:21:01.644833Z","end":"2026-03-20T10:21:01.77143Z","steps":["trace[683965968] 'process raft request'  (duration: 126.324925ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:01.815417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.086357ms","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-03-20T10:21:01.815476Z","caller":"traceutil/trace.go:171","msg":"trace[267555430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4960; }","duration":"167.191028ms","start":"2026-03-20T10:21:01.648272Z","end":"2026-03-20T10:21:01.815463Z","steps":["trace[267555430] 'agreement among raft nodes before linearized reading'  (duration: 166.885822ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:21:33.17464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.327594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-api-6cd8f54b8f-gllsg\" ","response":"range_response_count:1 size:10602"}
{"level":"info","ts":"2026-03-20T10:21:33.174764Z","caller":"traceutil/trace.go:171","msg":"trace[1002036830] range","detail":"{range_begin:/registry/pods/openstack/keystone-api-6cd8f54b8f-gllsg; range_end:; response_count:1; response_revision:5220; }","duration":"104.520547ms","start":"2026-03-20T10:21:33.070219Z","end":"2026-03-20T10:21:33.174739Z","steps":["trace[1002036830] 'agreement among raft nodes before linearized reading'  (duration: 104.19905ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:22:53.666002Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2762}
{"level":"info","ts":"2026-03-20T10:22:53.720807Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2762,"took":"53.413471ms","hash":2535168423,"current-db-size-bytes":41373696,"current-db-size":"41 MB","current-db-size-in-use-bytes":31510528,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-03-20T10:22:53.720886Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2535168423,"revision":2762,"compact-revision":-1}
{"level":"info","ts":"2026-03-20T10:26:35.023458Z","caller":"traceutil/trace.go:171","msg":"trace[1254784838] transaction","detail":"{read_only:false; response_revision:7234; number_of_response:1; }","duration":"118.785188ms","start":"2026-03-20T10:26:34.904639Z","end":"2026-03-20T10:26:35.023424Z","steps":["trace[1254784838] 'process raft request'  (duration: 58.505851ms)","trace[1254784838] 'compare'  (duration: 60.137634ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:26:42.537381Z","caller":"traceutil/trace.go:171","msg":"trace[1634306505] linearizableReadLoop","detail":"{readStateIndex:7670; appliedIndex:7669; }","duration":"112.636356ms","start":"2026-03-20T10:26:42.424719Z","end":"2026-03-20T10:26:42.537356Z","steps":["trace[1634306505] 'read index received'  (duration: 112.424902ms)","trace[1634306505] 'applied index is now lower than readState.Index'  (duration: 210.394µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:26:42.537442Z","caller":"traceutil/trace.go:171","msg":"trace[1391587901] transaction","detail":"{read_only:false; response_revision:7399; number_of_response:1; }","duration":"200.047242ms","start":"2026-03-20T10:26:42.337365Z","end":"2026-03-20T10:26:42.537412Z","steps":["trace[1391587901] 'process raft request'  (duration: 199.791817ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:42.53761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.868001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-88448\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-03-20T10:26:42.537657Z","caller":"traceutil/trace.go:171","msg":"trace[1120062558] range","detail":"{range_begin:/registry/pods/openstack/keepalived-88448; range_end:; response_count:1; response_revision:7399; }","duration":"112.971732ms","start":"2026-03-20T10:26:42.424673Z","end":"2026-03-20T10:26:42.537644Z","steps":["trace[1120062558] 'agreement among raft nodes before linearized reading'  (duration: 112.788409ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:45.77685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.249821ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164665964 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:7403 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:26:45.777092Z","caller":"traceutil/trace.go:171","msg":"trace[877462385] transaction","detail":"{read_only:false; response_revision:7415; number_of_response:1; }","duration":"123.93324ms","start":"2026-03-20T10:26:45.653141Z","end":"2026-03-20T10:26:45.777074Z","steps":["trace[877462385] 'process raft request'  (duration: 123.832148ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:26:45.777067Z","caller":"traceutil/trace.go:171","msg":"trace[1329847670] transaction","detail":"{read_only:false; response_revision:7414; number_of_response:1; }","duration":"197.971751ms","start":"2026-03-20T10:26:45.579048Z","end":"2026-03-20T10:26:45.77702Z","steps":["trace[1329847670] 'process raft request'  (duration: 97.455295ms)","trace[1329847670] 'compare'  (duration: 99.956935ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:26:45.777117Z","caller":"traceutil/trace.go:171","msg":"trace[308390238] linearizableReadLoop","detail":"{readStateIndex:7685; appliedIndex:7684; }","duration":"163.757542ms","start":"2026-03-20T10:26:45.613313Z","end":"2026-03-20T10:26:45.77707Z","steps":["trace[308390238] 'read index received'  (duration: 63.205275ms)","trace[308390238] 'applied index is now lower than readState.Index'  (duration: 100.546517ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:26:45.777335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.002057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-20T10:26:45.777419Z","caller":"traceutil/trace.go:171","msg":"trace[798139408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7415; }","duration":"164.10738ms","start":"2026-03-20T10:26:45.613287Z","end":"2026-03-20T10:26:45.777394Z","steps":["trace[798139408] 'agreement among raft nodes before linearized reading'  (duration: 163.903676ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:26:53.849869Z","caller":"traceutil/trace.go:171","msg":"trace[1150507457] transaction","detail":"{read_only:false; response_revision:7449; number_of_response:1; }","duration":"198.311919ms","start":"2026-03-20T10:26:53.651532Z","end":"2026-03-20T10:26:53.849844Z","steps":["trace[1150507457] 'process raft request'  (duration: 198.111405ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:53.998265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.617686ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164666068 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:7441 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:26:53.998397Z","caller":"traceutil/trace.go:171","msg":"trace[1811189277] linearizableReadLoop","detail":"{readStateIndex:7723; appliedIndex:7721; }","duration":"166.68058ms","start":"2026-03-20T10:26:53.831687Z","end":"2026-03-20T10:26:53.998368Z","steps":["trace[1811189277] 'read index received'  (duration: 17.994177ms)","trace[1811189277] 'applied index is now lower than readState.Index'  (duration: 148.685123ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:26:53.998469Z","caller":"traceutil/trace.go:171","msg":"trace[2118586542] transaction","detail":"{read_only:false; response_revision:7450; number_of_response:1; }","duration":"178.828401ms","start":"2026-03-20T10:26:53.819609Z","end":"2026-03-20T10:26:53.998437Z","steps":["trace[2118586542] 'process raft request'  (duration: 60.938351ms)","trace[2118586542] 'compare'  (duration: 117.463861ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:26:53.9986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.904115ms","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-03-20T10:26:53.99864Z","caller":"traceutil/trace.go:171","msg":"trace[1949914208] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7450; }","duration":"166.976316ms","start":"2026-03-20T10:26:53.831652Z","end":"2026-03-20T10:26:53.998628Z","steps":["trace[1949914208] 'agreement among raft nodes before linearized reading'  (duration: 166.837863ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:53.998642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.225222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-20T10:26:53.9987Z","caller":"traceutil/trace.go:171","msg":"trace[1614599158] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7450; }","duration":"163.312503ms","start":"2026-03-20T10:26:53.835372Z","end":"2026-03-20T10:26:53.998685Z","steps":["trace[1614599158] 'agreement among raft nodes before linearized reading'  (duration: 163.14819ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:53.998817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.428639ms","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-03-20T10:26:53.998837Z","caller":"traceutil/trace.go:171","msg":"trace[1718470330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7450; }","duration":"142.475739ms","start":"2026-03-20T10:26:53.856355Z","end":"2026-03-20T10:26:53.998831Z","steps":["trace[1718470330] 'agreement among raft nodes before linearized reading'  (duration: 142.423018ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:53.998914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.709862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T10:26:53.998964Z","caller":"traceutil/trace.go:171","msg":"trace[1171454233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7450; }","duration":"158.824554ms","start":"2026-03-20T10:26:53.840126Z","end":"2026-03-20T10:26:53.99895Z","steps":["trace[1171454233] 'agreement among raft nodes before linearized reading'  (duration: 158.676832ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:26:55.129126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.290538ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164666084 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:38e19d0abbcd4ee3>","response":"size:41"}
{"level":"warn","ts":"2026-03-20T10:26:55.129635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:26:54.680593Z","time spent":"449.037656ms","remote":"127.0.0.1:49896","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-20T10:26:55.291614Z","caller":"traceutil/trace.go:171","msg":"trace[117581067] transaction","detail":"{read_only:false; response_revision:7458; number_of_response:1; }","duration":"158.277523ms","start":"2026-03-20T10:26:55.133308Z","end":"2026-03-20T10:26:55.291586Z","steps":["trace[117581067] 'process raft request'  (duration: 158.11666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:26:56.028763Z","caller":"traceutil/trace.go:171","msg":"trace[1522114674] transaction","detail":"{read_only:false; response_revision:7459; number_of_response:1; }","duration":"171.959254ms","start":"2026-03-20T10:26:55.856781Z","end":"2026-03-20T10:26:56.02874Z","steps":["trace[1522114674] 'process raft request'  (duration: 171.834662ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:26:56.110416Z","caller":"traceutil/trace.go:171","msg":"trace[1205393786] transaction","detail":"{read_only:false; response_revision:7460; number_of_response:1; }","duration":"104.060708ms","start":"2026-03-20T10:26:56.00632Z","end":"2026-03-20T10:26:56.110381Z","steps":["trace[1205393786] 'process raft request'  (duration: 42.927333ms)","trace[1205393786] 'compare'  (duration: 60.860248ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:27:19.702353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.970789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:19435"}
{"level":"info","ts":"2026-03-20T10:27:19.702447Z","caller":"traceutil/trace.go:171","msg":"trace[858826000] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:7627; }","duration":"140.106172ms","start":"2026-03-20T10:27:19.562319Z","end":"2026-03-20T10:27:19.702425Z","steps":["trace[858826000] 'range keys from in-memory index tree'  (duration: 139.792486ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:22.708574Z","caller":"traceutil/trace.go:171","msg":"trace[1393931125] transaction","detail":"{read_only:false; response_revision:7644; number_of_response:1; }","duration":"327.452553ms","start":"2026-03-20T10:27:22.381099Z","end":"2026-03-20T10:27:22.708551Z","steps":["trace[1393931125] 'process raft request'  (duration: 317.443865ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:27:22.70871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:27:22.381084Z","time spent":"327.555355ms","remote":"127.0.0.1:50082","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:7635 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:27:22.81162Z","caller":"traceutil/trace.go:171","msg":"trace[1971723867] transaction","detail":"{read_only:false; response_revision:7645; number_of_response:1; }","duration":"270.569174ms","start":"2026-03-20T10:27:22.541034Z","end":"2026-03-20T10:27:22.811603Z","steps":["trace[1971723867] 'process raft request'  (duration: 269.757678ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:35.390039Z","caller":"traceutil/trace.go:171","msg":"trace[1244974370] linearizableReadLoop","detail":"{readStateIndex:8035; appliedIndex:8034; }","duration":"155.969708ms","start":"2026-03-20T10:27:35.23405Z","end":"2026-03-20T10:27:35.39002Z","steps":["trace[1244974370] 'read index received'  (duration: 155.848055ms)","trace[1244974370] 'applied index is now lower than readState.Index'  (duration: 120.693µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:27:35.390104Z","caller":"traceutil/trace.go:171","msg":"trace[509357964] transaction","detail":"{read_only:false; response_revision:7748; number_of_response:1; }","duration":"157.956417ms","start":"2026-03-20T10:27:35.232102Z","end":"2026-03-20T10:27:35.390058Z","steps":["trace[509357964] 'process raft request'  (duration: 157.772553ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:27:35.390365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.294784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-rd48b\" ","response":"range_response_count:1 size:2802"}
{"level":"info","ts":"2026-03-20T10:27:35.390433Z","caller":"traceutil/trace.go:171","msg":"trace[769188310] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-rd48b; range_end:; response_count:1; response_revision:7748; }","duration":"156.417107ms","start":"2026-03-20T10:27:35.233999Z","end":"2026-03-20T10:27:35.390416Z","steps":["trace[769188310] 'agreement among raft nodes before linearized reading'  (duration: 156.137911ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:35.526002Z","caller":"traceutil/trace.go:171","msg":"trace[504126943] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7749; }","duration":"133.103044ms","start":"2026-03-20T10:27:35.39288Z","end":"2026-03-20T10:27:35.525983Z","steps":["trace[504126943] 'process raft request'  (duration: 121.37877ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:35.526265Z","caller":"traceutil/trace.go:171","msg":"trace[880039648] linearizableReadLoop","detail":"{readStateIndex:8036; appliedIndex:8035; }","duration":"132.303598ms","start":"2026-03-20T10:27:35.393633Z","end":"2026-03-20T10:27:35.525937Z","steps":["trace[880039648] 'read index received'  (duration: 120.643815ms)","trace[880039648] 'applied index is now lower than readState.Index'  (duration: 11.657083ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:27:35.526267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.606375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-d01debd9-deeb-4d9a-bf24-c1ca7fa17baf\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-03-20T10:27:35.526318Z","caller":"traceutil/trace.go:171","msg":"trace[489461489] range","detail":"{range_begin:/registry/persistentvolumes/pvc-d01debd9-deeb-4d9a-bf24-c1ca7fa17baf; range_end:; response_count:1; response_revision:7750; }","duration":"132.714616ms","start":"2026-03-20T10:27:35.393589Z","end":"2026-03-20T10:27:35.526303Z","steps":["trace[489461489] 'agreement among raft nodes before linearized reading'  (duration: 132.523322ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:36.580157Z","caller":"traceutil/trace.go:171","msg":"trace[1053567481] transaction","detail":"{read_only:false; response_revision:7754; number_of_response:1; }","duration":"215.069861ms","start":"2026-03-20T10:27:36.365066Z","end":"2026-03-20T10:27:36.580136Z","steps":["trace[1053567481] 'process raft request'  (duration: 138.42788ms)","trace[1053567481] 'compare'  (duration: 76.117051ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:27:36.580057Z","caller":"traceutil/trace.go:171","msg":"trace[1482157936] linearizableReadLoop","detail":"{readStateIndex:8041; appliedIndex:8040; }","duration":"156.576659ms","start":"2026-03-20T10:27:36.423452Z","end":"2026-03-20T10:27:36.580029Z","steps":["trace[1482157936] 'read index received'  (duration: 80.06649ms)","trace[1482157936] 'applied index is now lower than readState.Index'  (duration: 76.508839ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:27:36.580566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.604173ms","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-03-20T10:27:36.580655Z","caller":"traceutil/trace.go:171","msg":"trace[802216509] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7754; }","duration":"133.744386ms","start":"2026-03-20T10:27:36.446889Z","end":"2026-03-20T10:27:36.580633Z","steps":["trace[802216509] 'agreement among raft nodes before linearized reading'  (duration: 133.493071ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:27:36.58098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.533368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T10:27:36.581047Z","caller":"traceutil/trace.go:171","msg":"trace[531724537] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7754; }","duration":"157.672651ms","start":"2026-03-20T10:27:36.42336Z","end":"2026-03-20T10:27:36.581033Z","steps":["trace[531724537] 'agreement among raft nodes before linearized reading'  (duration: 156.866375ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:36.74326Z","caller":"traceutil/trace.go:171","msg":"trace[1189137061] transaction","detail":"{read_only:false; response_revision:7759; number_of_response:1; }","duration":"105.544185ms","start":"2026-03-20T10:27:36.637676Z","end":"2026-03-20T10:27:36.74322Z","steps":["trace[1189137061] 'process raft request'  (duration: 44.973903ms)","trace[1189137061] 'compare'  (duration: 60.296667ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:27:37.45732Z","caller":"traceutil/trace.go:171","msg":"trace[107913942] linearizableReadLoop","detail":"{readStateIndex:8051; appliedIndex:8050; }","duration":"195.214177ms","start":"2026-03-20T10:27:37.26209Z","end":"2026-03-20T10:27:37.457304Z","steps":["trace[107913942] 'read index received'  (duration: 195.108315ms)","trace[107913942] 'applied index is now lower than readState.Index'  (duration: 105.052µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:27:37.457432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.337849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:27:37.457406Z","caller":"traceutil/trace.go:171","msg":"trace[1712453545] transaction","detail":"{read_only:false; response_revision:7763; number_of_response:1; }","duration":"341.237906ms","start":"2026-03-20T10:27:37.116137Z","end":"2026-03-20T10:27:37.457375Z","steps":["trace[1712453545] 'process raft request'  (duration: 341.051993ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:27:37.457456Z","caller":"traceutil/trace.go:171","msg":"trace[8785959] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:7763; }","duration":"195.417231ms","start":"2026-03-20T10:27:37.262031Z","end":"2026-03-20T10:27:37.457448Z","steps":["trace[8785959] 'agreement among raft nodes before linearized reading'  (duration: 195.333499ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:27:37.457567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:27:37.11612Z","time spent":"341.355339ms","remote":"127.0.0.1:47776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7438,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:7707 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7342 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >"}
{"level":"info","ts":"2026-03-20T10:27:53.672122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5768}
{"level":"info","ts":"2026-03-20T10:27:53.770599Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5768,"took":"96.641528ms","hash":4035137174,"current-db-size-bytes":43667456,"current-db-size":"44 MB","current-db-size-in-use-bytes":24326144,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-20T10:27:53.770674Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4035137174,"revision":5768,"compact-revision":2762}
{"level":"info","ts":"2026-03-20T10:28:28.077705Z","caller":"traceutil/trace.go:171","msg":"trace[1822110745] transaction","detail":"{read_only:false; response_revision:8250; number_of_response:1; }","duration":"130.39246ms","start":"2026-03-20T10:28:27.947195Z","end":"2026-03-20T10:28:28.077588Z","steps":["trace[1822110745] 'process raft request'  (duration: 62.093724ms)","trace[1822110745] 'compare'  (duration: 68.095502ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:28:49.203858Z","caller":"traceutil/trace.go:171","msg":"trace[584752818] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"181.80254ms","start":"2026-03-20T10:28:49.022025Z","end":"2026-03-20T10:28:49.203827Z","steps":["trace[584752818] 'process raft request'  (duration: 181.611086ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:28:49.204166Z","caller":"traceutil/trace.go:171","msg":"trace[872136835] linearizableReadLoop","detail":"{readStateIndex:8691; appliedIndex:8691; }","duration":"118.518813ms","start":"2026-03-20T10:28:49.085613Z","end":"2026-03-20T10:28:49.204132Z","steps":["trace[872136835] 'read index received'  (duration: 118.498283ms)","trace[872136835] 'applied index is now lower than readState.Index'  (duration: 17.42µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:28:49.204332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.702448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:28:49.204415Z","caller":"traceutil/trace.go:171","msg":"trace[941843687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8383; }","duration":"118.840071ms","start":"2026-03-20T10:28:49.085553Z","end":"2026-03-20T10:28:49.204393Z","steps":["trace[941843687] 'agreement among raft nodes before linearized reading'  (duration: 118.681578ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:28:49.707376Z","caller":"traceutil/trace.go:171","msg":"trace[362230349] linearizableReadLoop","detail":"{readStateIndex:8695; appliedIndex:8692; }","duration":"228.734213ms","start":"2026-03-20T10:28:49.478615Z","end":"2026-03-20T10:28:49.707349Z","steps":["trace[362230349] 'read index received'  (duration: 228.503578ms)","trace[362230349] 'applied index is now lower than readState.Index'  (duration: 229.395µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:28:49.707428Z","caller":"traceutil/trace.go:171","msg":"trace[640847852] transaction","detail":"{read_only:false; response_revision:8385; number_of_response:1; }","duration":"498.838366ms","start":"2026-03-20T10:28:49.208549Z","end":"2026-03-20T10:28:49.707388Z","steps":["trace[640847852] 'process raft request'  (duration: 498.572751ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:28:49.707484Z","caller":"traceutil/trace.go:171","msg":"trace[967622614] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"498.794606ms","start":"2026-03-20T10:28:49.208656Z","end":"2026-03-20T10:28:49.707451Z","steps":["trace[967622614] 'process raft request'  (duration: 498.630943ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:28:49.707531Z","caller":"traceutil/trace.go:171","msg":"trace[1935670043] transaction","detail":"{read_only:false; response_revision:8387; number_of_response:1; }","duration":"497.865747ms","start":"2026-03-20T10:28:49.209624Z","end":"2026-03-20T10:28:49.70749Z","steps":["trace[1935670043] 'process raft request'  (duration: 497.695354ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:28:49.707594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.961297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-20T10:28:49.707601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:28:49.208524Z","time spent":"498.972849ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8375 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-20T10:28:49.707641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.106865ms","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-03-20T10:28:49.707649Z","caller":"traceutil/trace.go:171","msg":"trace[205226217] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:8387; }","duration":"229.077009ms","start":"2026-03-20T10:28:49.47856Z","end":"2026-03-20T10:28:49.707637Z","steps":["trace[205226217] 'agreement among raft nodes before linearized reading'  (duration: 228.933317ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:28:49.707644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:28:49.208613Z","time spent":"498.940608ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8378 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:28:49.707678Z","caller":"traceutil/trace.go:171","msg":"trace[761472007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8387; }","duration":"122.212246ms","start":"2026-03-20T10:28:49.585456Z","end":"2026-03-20T10:28:49.707668Z","steps":["trace[761472007] 'agreement among raft nodes before linearized reading'  (duration: 122.048473ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:28:49.707699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:28:49.209603Z","time spent":"498.00891ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8377 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:28:49.707822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.707499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-88448\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-03-20T10:28:49.707879Z","caller":"traceutil/trace.go:171","msg":"trace[1872636734] range","detail":"{range_begin:/registry/pods/openstack/keepalived-88448; range_end:; response_count:1; response_revision:8387; }","duration":"105.78532ms","start":"2026-03-20T10:28:49.60208Z","end":"2026-03-20T10:28:49.707865Z","steps":["trace[1872636734] 'agreement among raft nodes before linearized reading'  (duration: 105.654207ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:28:49.90998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.755829ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164668925 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8379 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:28:49.910064Z","caller":"traceutil/trace.go:171","msg":"trace[418628725] linearizableReadLoop","detail":"{readStateIndex:8696; appliedIndex:8695; }","duration":"195.849059ms","start":"2026-03-20T10:28:49.714202Z","end":"2026-03-20T10:28:49.910051Z","steps":["trace[418628725] 'read index received'  (duration: 87.982137ms)","trace[418628725] 'applied index is now lower than readState.Index'  (duration: 107.866262ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:28:49.910043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.090674ms","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-03-20T10:28:49.910124Z","caller":"traceutil/trace.go:171","msg":"trace[2084300327] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8387; }","duration":"197.239297ms","start":"2026-03-20T10:28:49.712866Z","end":"2026-03-20T10:28:49.910105Z","steps":["trace[2084300327] 'range keys from in-memory index tree'  (duration: 196.738866ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:28:49.910127Z","caller":"traceutil/trace.go:171","msg":"trace[346915917] transaction","detail":"{read_only:false; response_revision:8388; number_of_response:1; }","duration":"195.991722ms","start":"2026-03-20T10:28:49.714099Z","end":"2026-03-20T10:28:49.910091Z","steps":["trace[346915917] 'process raft request'  (duration: 88.060659ms)","trace[346915917] 'compare'  (duration: 107.643797ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:28:49.910452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.239687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:29 size:261403"}
{"level":"info","ts":"2026-03-20T10:28:49.910506Z","caller":"traceutil/trace.go:171","msg":"trace[53661351] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:29; response_revision:8388; }","duration":"196.319168ms","start":"2026-03-20T10:28:49.714176Z","end":"2026-03-20T10:28:49.910495Z","steps":["trace[53661351] 'agreement among raft nodes before linearized reading'  (duration: 195.95935ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:28:50.191311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.847314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:28:50.191386Z","caller":"traceutil/trace.go:171","msg":"trace[1503638435] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8388; }","duration":"163.975847ms","start":"2026-03-20T10:28:50.027392Z","end":"2026-03-20T10:28:50.191368Z","steps":["trace[1503638435] 'range keys from in-memory index tree'  (duration: 163.736332ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:30:42.09856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.542262ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101842164671183 > lease_revoke:<id:38e19d0abbcd6159>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:30:42.098667Z","caller":"traceutil/trace.go:171","msg":"trace[2115400727] linearizableReadLoop","detail":"{readStateIndex:9573; appliedIndex:9572; }","duration":"139.707853ms","start":"2026-03-20T10:30:41.958941Z","end":"2026-03-20T10:30:42.098649Z","steps":["trace[2115400727] 'read index received'  (duration: 31.983568ms)","trace[2115400727] 'applied index is now lower than readState.Index'  (duration: 107.722855ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:30:42.098897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.943978ms","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-03-20T10:30:42.09895Z","caller":"traceutil/trace.go:171","msg":"trace[1625723542] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9234; }","duration":"140.04585ms","start":"2026-03-20T10:30:41.958887Z","end":"2026-03-20T10:30:42.098932Z","steps":["trace[1625723542] 'agreement among raft nodes before linearized reading'  (duration: 139.864156ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:31:09.286405Z","caller":"traceutil/trace.go:171","msg":"trace[1206649136] transaction","detail":"{read_only:false; response_revision:9479; number_of_response:1; }","duration":"103.502791ms","start":"2026-03-20T10:31:09.182876Z","end":"2026-03-20T10:31:09.286379Z","steps":["trace[1206649136] 'process raft request'  (duration: 103.378978ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:31:09.31275Z","caller":"traceutil/trace.go:171","msg":"trace[1364114435] transaction","detail":"{read_only:false; response_revision:9480; number_of_response:1; }","duration":"105.957901ms","start":"2026-03-20T10:31:09.206776Z","end":"2026-03-20T10:31:09.312734Z","steps":["trace[1364114435] 'process raft request'  (duration: 105.858459ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:31:35.977393Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-20T10:31:36.006685Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-20T10:31:36.006797Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-20T10:32:53.679466Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7960}
{"level":"info","ts":"2026-03-20T10:32:53.78074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7960,"took":"99.545623ms","hash":638361930,"current-db-size-bytes":43667456,"current-db-size":"44 MB","current-db-size-in-use-bytes":21159936,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-03-20T10:32:53.780819Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":638361930,"revision":7960,"compact-revision":5768}
{"level":"info","ts":"2026-03-20T10:37:53.685499Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10031}
{"level":"info","ts":"2026-03-20T10:37:53.757495Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10031,"took":"69.988077ms","hash":717827654,"current-db-size-bytes":43667456,"current-db-size":"44 MB","current-db-size-in-use-bytes":16052224,"current-db-size-in-use":"16 MB"}
{"level":"info","ts":"2026-03-20T10:37:53.757657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":717827654,"revision":10031,"compact-revision":7960}