{"level":"warn","ts":"2026-08-19T09:11:45.270909Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T09:11:45.271089Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.18:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.18:2380","--initial-cluster=instance=https://199.19.213.18:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.18:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.18:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-08-19T09:11:45.271233Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T09:11:45.27126Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.18:2380"]}
{"level":"info","ts":"2026-08-19T09:11:45.27129Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-19T09:11:45.272291Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"]}
{"level":"info","ts":"2026-08-19T09:11:45.272419Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.18:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-08-19T09:11:45.275199Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.42405ms"}
{"level":"info","ts":"2026-08-19T09:11:45.285908Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d0358acb671c233","cluster-id":"ba212af698de913f"}
{"level":"info","ts":"2026-08-19T09:11:45.286076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-19T09:11:45.286117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 0"}
{"level":"info","ts":"2026-08-19T09:11:45.286139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d0358acb671c233 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-19T09:11:45.28616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 1"}
{"level":"info","ts":"2026-08-19T09:11:45.286216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"}
{"level":"warn","ts":"2026-08-19T09:11:45.291454Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-19T09:11:45.29278Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-19T09:11:45.293804Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-08-19T09:11:45.296064Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d0358acb671c233","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-19T09:11:45.296259Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-19T09:11:45.296213Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d0358acb671c233","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-19T09:11:45.296357Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-19T09:11:45.296431Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-19T09:11:45.297671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"}
{"level":"info","ts":"2026-08-19T09:11:45.297988Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","added-peer-id":"6d0358acb671c233","added-peer-peer-urls":["https://199.19.213.18:2380"]}
{"level":"info","ts":"2026-08-19T09:11:45.300555Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-19T09:11:45.300653Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.18:2380"}
{"level":"info","ts":"2026-08-19T09:11:45.300711Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.18:2380"}
{"level":"info","ts":"2026-08-19T09:11:45.300934Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d0358acb671c233","initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-19T09:11:45.301016Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-19T09:11:46.187036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-19T09:11:46.187094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-19T09:11:46.18713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgPreVoteResp from 6d0358acb671c233 at term 1"}
{"level":"info","ts":"2026-08-19T09:11:46.187149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became candidate at term 2"}
{"level":"info","ts":"2026-08-19T09:11:46.18716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgVoteResp from 6d0358acb671c233 at term 2"}
{"level":"info","ts":"2026-08-19T09:11:46.187176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became leader at term 2"}
{"level":"info","ts":"2026-08-19T09:11:46.18719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d0358acb671c233 elected leader 6d0358acb671c233 at term 2"}
{"level":"info","ts":"2026-08-19T09:11:46.188362Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d0358acb671c233","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.18:2379]}","request-path":"/0/members/6d0358acb671c233/attributes","cluster-id":"ba212af698de913f","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-19T09:11:46.188376Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T09:11:46.188469Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T09:11:46.188444Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:11:46.188615Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-19T09:11:46.188715Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-19T09:11:46.189571Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:11:46.189691Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:11:46.189728Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:11:46.192194Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.18:2379"}
{"level":"info","ts":"2026-08-19T09:11:46.193113Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-19T09:12:31.118147Z","caller":"traceutil/trace.go:171","msg":"trace[1512521040] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"185.179409ms","start":"2026-08-19T09:12:30.932917Z","end":"2026-08-19T09:12:31.118097Z","steps":["trace[1512521040] 'process raft request'  (duration: 184.027411ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:12:31.435731Z","caller":"traceutil/trace.go:171","msg":"trace[856088766] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"260.239918ms","start":"2026-08-19T09:12:31.175465Z","end":"2026-08-19T09:12:31.435705Z","steps":["trace[856088766] 'process raft request'  (duration: 260.187207ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:12:31.43576Z","caller":"traceutil/trace.go:171","msg":"trace[405987674] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"296.176154ms","start":"2026-08-19T09:12:31.139545Z","end":"2026-08-19T09:12:31.435721Z","steps":["trace[405987674] 'process raft request'  (duration: 225.653156ms)","trace[405987674] 'compare'  (duration: 70.096796ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:12:32.398696Z","caller":"traceutil/trace.go:171","msg":"trace[2913759] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"309.361927ms","start":"2026-08-19T09:12:32.089312Z","end":"2026-08-19T09:12:32.398674Z","steps":["trace[2913759] 'read index received'  (duration: 308.704631ms)","trace[2913759] 'applied index is now lower than readState.Index'  (duration: 656.686µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:12:32.398793Z","caller":"traceutil/trace.go:171","msg":"trace[1712316204] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"504.232817ms","start":"2026-08-19T09:12:31.894517Z","end":"2026-08-19T09:12:32.398749Z","steps":["trace[1712316204] 'process raft request'  (duration: 503.746555ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:12:32.398852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.524522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T09:12:32.398936Z","caller":"traceutil/trace.go:171","msg":"trace[1577665369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"309.669885ms","start":"2026-08-19T09:12:32.089254Z","end":"2026-08-19T09:12:32.398923Z","steps":["trace[1577665369] 'agreement among raft nodes before linearized reading'  (duration: 309.507531ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:12:32.398966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:12:32.089232Z","time spent":"309.726346ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-19T09:12:32.399013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.39335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:12:32.399125Z","caller":"traceutil/trace.go:171","msg":"trace[770169965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"210.577026ms","start":"2026-08-19T09:12:32.188525Z","end":"2026-08-19T09:12:32.399102Z","steps":["trace[770169965] 'agreement among raft nodes before linearized reading'  (duration: 210.34726ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:12:32.399035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.193439ms","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-08-19T09:12:32.399253Z","caller":"traceutil/trace.go:171","msg":"trace[264764083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"241.474647ms","start":"2026-08-19T09:12:32.157761Z","end":"2026-08-19T09:12:32.399235Z","steps":["trace[264764083] 'agreement among raft nodes before linearized reading'  (duration: 241.078776ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:12:32.399697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:12:31.894468Z","time spent":"504.429842ms","remote":"127.0.0.1:55090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:625 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036077 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-08-19T09:12:47.980909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.076354ms","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-08-19T09:12:47.981036Z","caller":"traceutil/trace.go:171","msg":"trace[1525041616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"185.275609ms","start":"2026-08-19T09:12:47.795733Z","end":"2026-08-19T09:12:47.981009Z","steps":["trace[1525041616] 'range keys from in-memory index tree'  (duration: 184.816738ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:13:15.843528Z","caller":"traceutil/trace.go:171","msg":"trace[1352190524] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"127.713851ms","start":"2026-08-19T09:13:15.715773Z","end":"2026-08-19T09:13:15.843486Z","steps":["trace[1352190524] 'process raft request'  (duration: 127.485475ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:01.483882Z","caller":"traceutil/trace.go:171","msg":"trace[1797459631] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"295.713238ms","start":"2026-08-19T09:14:01.188129Z","end":"2026-08-19T09:14:01.483842Z","steps":["trace[1797459631] 'read index received'  (duration: 224.622199ms)","trace[1797459631] 'applied index is now lower than readState.Index'  (duration: 71.089289ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:14:01.484065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.931082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:14:01.48414Z","caller":"traceutil/trace.go:171","msg":"trace[2015252087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1858; }","duration":"296.054075ms","start":"2026-08-19T09:14:01.18807Z","end":"2026-08-19T09:14:01.484124Z","steps":["trace[2015252087] 'agreement among raft nodes before linearized reading'  (duration: 295.942113ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:01.483987Z","caller":"traceutil/trace.go:171","msg":"trace[1635615155] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"302.135668ms","start":"2026-08-19T09:14:01.181822Z","end":"2026-08-19T09:14:01.483957Z","steps":["trace[1635615155] 'process raft request'  (duration: 230.955218ms)","trace[1635615155] 'compare'  (duration: 70.73393ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:14:01.484631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:14:01.181792Z","time spent":"302.414854ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1785 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T09:14:45.456016Z","caller":"traceutil/trace.go:171","msg":"trace[1173352412] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"166.896415ms","start":"2026-08-19T09:14:45.289095Z","end":"2026-08-19T09:14:45.455991Z","steps":["trace[1173352412] 'process raft request'  (duration: 166.67296ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:14:46.199651Z","caller":"traceutil/trace.go:171","msg":"trace[1187164605] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"166.121846ms","start":"2026-08-19T09:14:46.033503Z","end":"2026-08-19T09:14:46.199625Z","steps":["trace[1187164605] 'read index received'  (duration: 165.888711ms)","trace[1187164605] 'applied index is now lower than readState.Index'  (duration: 232.165µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:14:46.199711Z","caller":"traceutil/trace.go:171","msg":"trace[128262992] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"166.976157ms","start":"2026-08-19T09:14:46.032697Z","end":"2026-08-19T09:14:46.199673Z","steps":["trace[128262992] 'process raft request'  (duration: 166.797743ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:14:46.199877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.327232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:14:46.199965Z","caller":"traceutil/trace.go:171","msg":"trace[1625607839] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2156; }","duration":"166.467235ms","start":"2026-08-19T09:14:46.033478Z","end":"2026-08-19T09:14:46.199945Z","steps":["trace[1625607839] 'agreement among raft nodes before linearized reading'  (duration: 166.28174ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:16:15.598382Z","caller":"traceutil/trace.go:171","msg":"trace[1879575228] linearizableReadLoop","detail":"{readStateIndex:2944; appliedIndex:2943; }","duration":"105.92727ms","start":"2026-08-19T09:16:15.492436Z","end":"2026-08-19T09:16:15.598363Z","steps":["trace[1879575228] 'read index received'  (duration: 105.766706ms)","trace[1879575228] 'applied index is now lower than readState.Index'  (duration: 159.924µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:16:15.598444Z","caller":"traceutil/trace.go:171","msg":"trace[931827898] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"123.254224ms","start":"2026-08-19T09:16:15.475162Z","end":"2026-08-19T09:16:15.598416Z","steps":["trace[931827898] 'process raft request'  (duration: 123.08685ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:16:15.598539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.101144ms","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-08-19T09:16:15.598565Z","caller":"traceutil/trace.go:171","msg":"trace[1771221678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2832; }","duration":"106.189636ms","start":"2026-08-19T09:16:15.492368Z","end":"2026-08-19T09:16:15.598558Z","steps":["trace[1771221678] 'agreement among raft nodes before linearized reading'  (duration: 106.076043ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:16:21.397842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.450593ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13993704497654111815 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2853 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:16:21.397935Z","caller":"traceutil/trace.go:171","msg":"trace[235297995] linearizableReadLoop","detail":"{readStateIndex:2977; appliedIndex:2976; }","duration":"208.56995ms","start":"2026-08-19T09:16:21.189351Z","end":"2026-08-19T09:16:21.397921Z","steps":["trace[235297995] 'read index received'  (duration: 38.637855ms)","trace[235297995] 'applied index is now lower than readState.Index'  (duration: 169.931055ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:16:21.397983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.655812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:16:21.398008Z","caller":"traceutil/trace.go:171","msg":"trace[955659606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2864; }","duration":"208.738675ms","start":"2026-08-19T09:16:21.189258Z","end":"2026-08-19T09:16:21.397996Z","steps":["trace[955659606] 'agreement among raft nodes before linearized reading'  (duration: 208.696764ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:16:21.398041Z","caller":"traceutil/trace.go:171","msg":"trace[426049981] transaction","detail":"{read_only:false; response_revision:2864; number_of_response:1; }","duration":"258.107502ms","start":"2026-08-19T09:16:21.139889Z","end":"2026-08-19T09:16:21.397997Z","steps":["trace[426049981] 'process raft request'  (duration: 88.187197ms)","trace[426049981] 'compare'  (duration: 169.308619ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:18:51.971088Z","caller":"traceutil/trace.go:171","msg":"trace[33918615] transaction","detail":"{read_only:false; response_revision:3859; number_of_response:1; }","duration":"127.776892ms","start":"2026-08-19T09:18:51.843289Z","end":"2026-08-19T09:18:51.971065Z","steps":["trace[33918615] 'process raft request'  (duration: 127.640849ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:20:18.399596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.720818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16178"}
{"level":"warn","ts":"2026-08-19T09:20:18.399764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.608583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b7e14fb-bf0c-46a5-81da-66cf6b15073b\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-08-19T09:20:18.400335Z","caller":"traceutil/trace.go:171","msg":"trace[1744280410] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5052; }","duration":"242.512627ms","start":"2026-08-19T09:20:18.1578Z","end":"2026-08-19T09:20:18.400313Z","steps":["trace[1744280410] 'range keys from in-memory index tree'  (duration: 241.479942ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:18.400494Z","caller":"traceutil/trace.go:171","msg":"trace[1260301873] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b7e14fb-bf0c-46a5-81da-66cf6b15073b; range_end:; response_count:1; response_revision:5052; }","duration":"128.377583ms","start":"2026-08-19T09:20:18.272096Z","end":"2026-08-19T09:20:18.400474Z","steps":["trace[1260301873] 'range keys from in-memory index tree'  (duration: 127.389868ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:20:18.400086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.240827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786893"}
{"level":"info","ts":"2026-08-19T09:20:18.400627Z","caller":"traceutil/trace.go:171","msg":"trace[1263169837] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5052; }","duration":"261.82819ms","start":"2026-08-19T09:20:18.138774Z","end":"2026-08-19T09:20:18.400602Z","steps":["trace[1263169837] 'range keys from in-memory index tree'  (duration: 260.712993ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:18.870861Z","caller":"traceutil/trace.go:171","msg":"trace[1877475905] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"107.011841ms","start":"2026-08-19T09:20:18.763819Z","end":"2026-08-19T09:20:18.870831Z","steps":["trace[1877475905] 'process raft request'  (duration: 64.314084ms)","trace[1877475905] 'compare'  (duration: 42.474721ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:20:31.179103Z","caller":"traceutil/trace.go:171","msg":"trace[1435578698] linearizableReadLoop","detail":"{readStateIndex:5517; appliedIndex:5516; }","duration":"328.515402ms","start":"2026-08-19T09:20:30.850558Z","end":"2026-08-19T09:20:31.179074Z","steps":["trace[1435578698] 'read index received'  (duration: 300.808764ms)","trace[1435578698] 'applied index is now lower than readState.Index'  (duration: 27.705208ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:20:31.17917Z","caller":"traceutil/trace.go:171","msg":"trace[728541328] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"359.111672ms","start":"2026-08-19T09:20:30.820026Z","end":"2026-08-19T09:20:31.179137Z","steps":["trace[728541328] 'process raft request'  (duration: 331.312501ms)","trace[728541328] 'compare'  (duration: 27.449082ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:20:31.179281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.702116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:20:31.17934Z","caller":"traceutil/trace.go:171","msg":"trace[464338370] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5313; }","duration":"328.812439ms","start":"2026-08-19T09:20:30.850515Z","end":"2026-08-19T09:20:31.179327Z","steps":["trace[464338370] 'agreement among raft nodes before linearized reading'  (duration: 328.684556ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:20:31.179379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:20:30.850491Z","time spent":"328.882481ms","remote":"127.0.0.1:59264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T09:20:31.179529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:20:30.819999Z","time spent":"359.238175ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5261 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T09:20:31.191406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.657453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8c997\" ","response":"range_response_count:1 size:6520"}
{"level":"warn","ts":"2026-08-19T09:20:31.191388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.971684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-19T09:20:31.191442Z","caller":"traceutil/trace.go:171","msg":"trace[1081070327] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8c997; range_end:; response_count:1; response_revision:5314; }","duration":"171.729275ms","start":"2026-08-19T09:20:31.019704Z","end":"2026-08-19T09:20:31.191433Z","steps":["trace[1081070327] 'agreement among raft nodes before linearized reading'  (duration: 171.553681ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:31.191466Z","caller":"traceutil/trace.go:171","msg":"trace[1126654650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5314; }","duration":"253.092947ms","start":"2026-08-19T09:20:30.938359Z","end":"2026-08-19T09:20:31.191452Z","steps":["trace[1126654650] 'agreement among raft nodes before linearized reading'  (duration: 252.877461ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:31.19134Z","caller":"traceutil/trace.go:171","msg":"trace[967977779] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"171.430637ms","start":"2026-08-19T09:20:31.019876Z","end":"2026-08-19T09:20:31.191306Z","steps":["trace[967977779] 'process raft request'  (duration: 171.247043ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:20:31.191476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.837794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T09:20:31.191547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.734177ms","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-08-19T09:20:31.191567Z","caller":"traceutil/trace.go:171","msg":"trace[626614400] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5314; }","duration":"235.957317ms","start":"2026-08-19T09:20:30.955593Z","end":"2026-08-19T09:20:31.19155Z","steps":["trace[626614400] 'agreement among raft nodes before linearized reading'  (duration: 235.791003ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:31.191626Z","caller":"traceutil/trace.go:171","msg":"trace[402668227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5314; }","duration":"232.85319ms","start":"2026-08-19T09:20:30.958751Z","end":"2026-08-19T09:20:31.191604Z","steps":["trace[402668227] 'agreement among raft nodes before linearized reading'  (duration: 232.592724ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:20:31.297919Z","caller":"traceutil/trace.go:171","msg":"trace[196786499] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"101.072664ms","start":"2026-08-19T09:20:31.196821Z","end":"2026-08-19T09:20:31.297894Z","steps":["trace[196786499] 'process raft request'  (duration: 96.076992ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:21:46.218407Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3001}
{"level":"info","ts":"2026-08-19T09:21:46.301711Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3001,"took":"81.768982ms","hash":1907555889,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":31866880,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T09:21:46.301795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1907555889,"revision":3001,"compact-revision":-1}
{"level":"info","ts":"2026-08-19T09:26:36.636945Z","caller":"traceutil/trace.go:171","msg":"trace[1872097160] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"124.788511ms","start":"2026-08-19T09:26:36.512111Z","end":"2026-08-19T09:26:36.6369Z","steps":["trace[1872097160] 'process raft request'  (duration: 100.903931ms)","trace[1872097160] 'compare'  (duration: 23.533502ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:26:46.224661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6104}
{"level":"info","ts":"2026-08-19T09:26:46.319206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6104,"took":"92.682262ms","hash":2612191813,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":23392256,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-19T09:26:46.319274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2612191813,"revision":6104,"compact-revision":3001}
{"level":"info","ts":"2026-08-19T09:26:47.93616Z","caller":"traceutil/trace.go:171","msg":"trace[1120809704] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"108.453367ms","start":"2026-08-19T09:26:47.827682Z","end":"2026-08-19T09:26:47.936135Z","steps":["trace[1120809704] 'process raft request'  (duration: 108.222971ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:26:48.931668Z","caller":"traceutil/trace.go:171","msg":"trace[608534491] linearizableReadLoop","detail":"{readStateIndex:8608; appliedIndex:8607; }","duration":"271.560897ms","start":"2026-08-19T09:26:48.66007Z","end":"2026-08-19T09:26:48.931631Z","steps":["trace[608534491] 'read index received'  (duration: 271.378572ms)","trace[608534491] 'applied index is now lower than readState.Index'  (duration: 180.875µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:26:48.931819Z","caller":"traceutil/trace.go:171","msg":"trace[1628849739] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"367.642963ms","start":"2026-08-19T09:26:48.564163Z","end":"2026-08-19T09:26:48.931806Z","steps":["trace[1628849739] 'process raft request'  (duration: 367.306044ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:26:48.931929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:26:48.56414Z","time spent":"367.713875ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8302 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T09:26:48.931965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.880545ms","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":"info","ts":"2026-08-19T09:26:48.932048Z","caller":"traceutil/trace.go:171","msg":"trace[1537942495] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:8311; }","duration":"272.008199ms","start":"2026-08-19T09:26:48.660021Z","end":"2026-08-19T09:26:48.932029Z","steps":["trace[1537942495] 'agreement among raft nodes before linearized reading'  (duration: 271.877266ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:26:48.953489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.198094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-08-19T09:26:48.953564Z","caller":"traceutil/trace.go:171","msg":"trace[1138245120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8312; }","duration":"261.314137ms","start":"2026-08-19T09:26:48.692232Z","end":"2026-08-19T09:26:48.953546Z","steps":["trace[1138245120] 'agreement among raft nodes before linearized reading'  (duration: 261.122903ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:26:48.953631Z","caller":"traceutil/trace.go:171","msg":"trace[1877198756] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"276.039066ms","start":"2026-08-19T09:26:48.677548Z","end":"2026-08-19T09:26:48.953587Z","steps":["trace[1877198756] 'process raft request'  (duration: 275.685888ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:26:49.515693Z","caller":"traceutil/trace.go:171","msg":"trace[1661683825] linearizableReadLoop","detail":"{readStateIndex:8614; appliedIndex:8613; }","duration":"130.387452ms","start":"2026-08-19T09:26:49.385284Z","end":"2026-08-19T09:26:49.515671Z","steps":["trace[1661683825] 'read index received'  (duration: 130.185378ms)","trace[1661683825] 'applied index is now lower than readState.Index'  (duration: 201.294µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:26:49.516004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.70599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:223774"}
{"level":"info","ts":"2026-08-19T09:26:49.516033Z","caller":"traceutil/trace.go:171","msg":"trace[917425215] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8316; }","duration":"130.768242ms","start":"2026-08-19T09:26:49.385257Z","end":"2026-08-19T09:26:49.516025Z","steps":["trace[917425215] 'agreement among raft nodes before linearized reading'  (duration: 130.491445ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:16.22003Z","caller":"traceutil/trace.go:171","msg":"trace[811032960] linearizableReadLoop","detail":"{readStateIndex:8815; appliedIndex:8814; }","duration":"125.276728ms","start":"2026-08-19T09:27:16.094722Z","end":"2026-08-19T09:27:16.219998Z","steps":["trace[811032960] 'read index received'  (duration: 124.775445ms)","trace[811032960] 'applied index is now lower than readState.Index'  (duration: 499.453µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:27:16.220563Z","caller":"traceutil/trace.go:171","msg":"trace[965637061] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"150.826321ms","start":"2026-08-19T09:27:16.069723Z","end":"2026-08-19T09:27:16.220549Z","steps":["trace[965637061] 'process raft request'  (duration: 149.888558ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:27:16.220975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.227031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-19T09:27:16.221267Z","caller":"traceutil/trace.go:171","msg":"trace[569026856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8510; }","duration":"126.59842ms","start":"2026-08-19T09:27:16.094652Z","end":"2026-08-19T09:27:16.221251Z","steps":["trace[569026856] 'agreement among raft nodes before linearized reading'  (duration: 126.19553ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:27:16.221299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.740082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-08-19T09:27:16.221401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.572167ms","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-08-19T09:27:16.221489Z","caller":"traceutil/trace.go:171","msg":"trace[952220297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8510; }","duration":"105.691299ms","start":"2026-08-19T09:27:16.115778Z","end":"2026-08-19T09:27:16.221469Z","steps":["trace[952220297] 'agreement among raft nodes before linearized reading'  (duration: 105.400352ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:16.221487Z","caller":"traceutil/trace.go:171","msg":"trace[390876714] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8510; }","duration":"112.979257ms","start":"2026-08-19T09:27:16.108464Z","end":"2026-08-19T09:27:16.221444Z","steps":["trace[390876714] 'agreement among raft nodes before linearized reading'  (duration: 112.563867ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:28.979499Z","caller":"traceutil/trace.go:171","msg":"trace[1473007578] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"126.453986ms","start":"2026-08-19T09:27:28.85301Z","end":"2026-08-19T09:27:28.979464Z","steps":["trace[1473007578] 'process raft request'  (duration: 126.254161ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:29.467696Z","caller":"traceutil/trace.go:171","msg":"trace[609699485] linearizableReadLoop","detail":"{readStateIndex:8934; appliedIndex:8933; }","duration":"104.409429ms","start":"2026-08-19T09:27:29.363256Z","end":"2026-08-19T09:27:29.467666Z","steps":["trace[609699485] 'read index received'  (duration: 95.609243ms)","trace[609699485] 'applied index is now lower than readState.Index'  (duration: 8.798506ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:27:29.467735Z","caller":"traceutil/trace.go:171","msg":"trace[1341353636] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"111.8333ms","start":"2026-08-19T09:27:29.355863Z","end":"2026-08-19T09:27:29.467696Z","steps":["trace[1341353636] 'process raft request'  (duration: 103.050705ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:27:29.467868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.591894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-19T09:27:29.467947Z","caller":"traceutil/trace.go:171","msg":"trace[7616908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8624; }","duration":"104.715877ms","start":"2026-08-19T09:27:29.363214Z","end":"2026-08-19T09:27:29.46793Z","steps":["trace[7616908] 'agreement among raft nodes before linearized reading'  (duration: 104.525452ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:29.661512Z","caller":"traceutil/trace.go:171","msg":"trace[405440520] linearizableReadLoop","detail":"{readStateIndex:8936; appliedIndex:8934; }","duration":"188.374857ms","start":"2026-08-19T09:27:29.473109Z","end":"2026-08-19T09:27:29.661484Z","steps":["trace[405440520] 'read index received'  (duration: 127.44692ms)","trace[405440520] 'applied index is now lower than readState.Index'  (duration: 60.926997ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:27:29.661716Z","caller":"traceutil/trace.go:171","msg":"trace[1001092467] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"189.747701ms","start":"2026-08-19T09:27:29.471951Z","end":"2026-08-19T09:27:29.661699Z","steps":["trace[1001092467] 'process raft request'  (duration: 128.616789ms)","trace[1001092467] 'compare'  (duration: 60.696022ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:27:29.661756Z","caller":"traceutil/trace.go:171","msg":"trace[1294355704] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"189.546806ms","start":"2026-08-19T09:27:29.472171Z","end":"2026-08-19T09:27:29.661718Z","steps":["trace[1294355704] 'process raft request'  (duration: 189.260379ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:27:29.662043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.885689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-19T09:27:29.662144Z","caller":"traceutil/trace.go:171","msg":"trace[702580178] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:8626; }","duration":"189.032913ms","start":"2026-08-19T09:27:29.473085Z","end":"2026-08-19T09:27:29.662118Z","steps":["trace[702580178] 'agreement among raft nodes before linearized reading'  (duration: 188.627654ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:29.797492Z","caller":"traceutil/trace.go:171","msg":"trace[1804174775] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"111.296695ms","start":"2026-08-19T09:27:29.686168Z","end":"2026-08-19T09:27:29.797465Z","steps":["trace[1804174775] 'process raft request'  (duration: 83.053126ms)","trace[1804174775] 'compare'  (duration: 28.094186ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:27:30.431005Z","caller":"traceutil/trace.go:171","msg":"trace[2053313443] linearizableReadLoop","detail":"{readStateIndex:8941; appliedIndex:8940; }","duration":"104.259924ms","start":"2026-08-19T09:27:30.326717Z","end":"2026-08-19T09:27:30.430977Z","steps":["trace[2053313443] 'read index received'  (duration: 104.107471ms)","trace[2053313443] 'applied index is now lower than readState.Index'  (duration: 151.543µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:27:30.43123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.493541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T09:27:30.431271Z","caller":"traceutil/trace.go:171","msg":"trace[873684825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8631; }","duration":"104.576003ms","start":"2026-08-19T09:27:30.326683Z","end":"2026-08-19T09:27:30.431259Z","steps":["trace[873684825] 'agreement among raft nodes before linearized reading'  (duration: 104.426229ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:30.431056Z","caller":"traceutil/trace.go:171","msg":"trace[1190461426] transaction","detail":"{read_only:false; response_revision:8631; number_of_response:1; }","duration":"105.969686ms","start":"2026-08-19T09:27:30.325055Z","end":"2026-08-19T09:27:30.431025Z","steps":["trace[1190461426] 'process raft request'  (duration: 105.74409ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:27:30.810717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.255602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-19T09:27:30.810803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.659896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rook-ceph-config\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:27:30.810832Z","caller":"traceutil/trace.go:171","msg":"trace[2030526213] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:8635; }","duration":"251.413086ms","start":"2026-08-19T09:27:30.559387Z","end":"2026-08-19T09:27:30.8108Z","steps":["trace[2030526213] 'count revisions from in-memory index tree'  (duration: 251.187221ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:27:30.810896Z","caller":"traceutil/trace.go:171","msg":"trace[1272778188] range","detail":"{range_begin:/registry/secrets/openstack/rook-ceph-config; range_end:; response_count:0; response_revision:8635; }","duration":"311.814949ms","start":"2026-08-19T09:27:30.499062Z","end":"2026-08-19T09:27:30.810877Z","steps":["trace[1272778188] 'range keys from in-memory index tree'  (duration: 311.583544ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:27:30.811033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:27:30.499047Z","time spent":"311.970834ms","remote":"127.0.0.1:55090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/openstack/rook-ceph-config\" "}
{"level":"info","ts":"2026-08-19T09:28:17.942178Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000249a.wal"}
{"level":"info","ts":"2026-08-19T09:28:31.467935Z","caller":"traceutil/trace.go:171","msg":"trace[1018797886] transaction","detail":"{read_only:false; response_revision:9285; number_of_response:1; }","duration":"125.80215ms","start":"2026-08-19T09:28:31.342087Z","end":"2026-08-19T09:28:31.467889Z","steps":["trace[1018797886] 'process raft request'  (duration: 65.112368ms)","trace[1018797886] 'compare'  (duration: 60.531788ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:29:23.485839Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d0358acb671c233","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T09:29:23.494223Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-19T09:29:23.494359Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-19T09:31:46.230155Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8301}
{"level":"info","ts":"2026-08-19T09:31:46.305022Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8301,"took":"72.822283ms","hash":2462698080,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":26451968,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-19T09:31:46.305116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2462698080,"revision":8301,"compact-revision":6104}
{"level":"warn","ts":"2026-08-19T09:32:24.304443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.995204ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13993704497654133703 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:11184 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:32:24.304675Z","caller":"traceutil/trace.go:171","msg":"trace[1943119885] linearizableReadLoop","detail":"{readStateIndex:11579; appliedIndex:11577; }","duration":"282.342586ms","start":"2026-08-19T09:32:24.022319Z","end":"2026-08-19T09:32:24.304662Z","steps":["trace[1943119885] 'read index received'  (duration: 142.603863ms)","trace[1943119885] 'applied index is now lower than readState.Index'  (duration: 139.737943ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:32:24.304751Z","caller":"traceutil/trace.go:171","msg":"trace[441916525] transaction","detail":"{read_only:false; response_revision:11194; number_of_response:1; }","duration":"324.759859ms","start":"2026-08-19T09:32:23.97998Z","end":"2026-08-19T09:32:24.30474Z","steps":["trace[441916525] 'process raft request'  (duration: 184.944274ms)","trace[441916525] 'compare'  (duration: 138.781989ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:32:24.304815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:32:23.979951Z","time spent":"324.832061ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:11184 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-19T09:32:24.305009Z","caller":"traceutil/trace.go:171","msg":"trace[1642841576] transaction","detail":"{read_only:false; response_revision:11196; number_of_response:1; }","duration":"224.888106ms","start":"2026-08-19T09:32:24.080082Z","end":"2026-08-19T09:32:24.30497Z","steps":["trace[1642841576] 'process raft request'  (duration: 224.544218ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:32:24.305196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.866549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-08-19T09:32:24.30511Z","caller":"traceutil/trace.go:171","msg":"trace[533080385] transaction","detail":"{read_only:false; response_revision:11195; number_of_response:1; }","duration":"324.81207ms","start":"2026-08-19T09:32:23.980283Z","end":"2026-08-19T09:32:24.305095Z","steps":["trace[533080385] 'process raft request'  (duration: 324.268297ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:24.305273Z","caller":"traceutil/trace.go:171","msg":"trace[58527105] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:11196; }","duration":"283.055493ms","start":"2026-08-19T09:32:24.022197Z","end":"2026-08-19T09:32:24.305253Z","steps":["trace[58527105] 'agreement among raft nodes before linearized reading'  (duration: 282.803677ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:32:24.305415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:32:23.980256Z","time spent":"325.048085ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:11183 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T09:32:24.317558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.478495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-7578d5486c-ss7tw.18cd2b01722b4921\" ","response":"range_response_count:1 size:811"}
{"level":"warn","ts":"2026-08-19T09:32:24.317571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.603556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:32:24.317616Z","caller":"traceutil/trace.go:171","msg":"trace[1344456062] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-7578d5486c-ss7tw.18cd2b01722b4921; range_end:; response_count:1; response_revision:11197; }","duration":"288.557217ms","start":"2026-08-19T09:32:24.029042Z","end":"2026-08-19T09:32:24.317599Z","steps":["trace[1344456062] 'agreement among raft nodes before linearized reading'  (duration: 288.410334ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:24.317625Z","caller":"traceutil/trace.go:171","msg":"trace[852385513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11197; }","duration":"129.702759ms","start":"2026-08-19T09:32:24.187909Z","end":"2026-08-19T09:32:24.317612Z","steps":["trace[852385513] 'agreement among raft nodes before linearized reading'  (duration: 129.603416ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:32:24.317659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.840642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T09:32:24.317711Z","caller":"traceutil/trace.go:171","msg":"trace[261444540] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:11197; }","duration":"228.957955ms","start":"2026-08-19T09:32:24.08874Z","end":"2026-08-19T09:32:24.317698Z","steps":["trace[261444540] 'agreement among raft nodes before linearized reading'  (duration: 228.791341ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:32:24.317708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.208345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:32:24.317808Z","caller":"traceutil/trace.go:171","msg":"trace[1949881313] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:11197; }","duration":"255.373249ms","start":"2026-08-19T09:32:24.062406Z","end":"2026-08-19T09:32:24.317779Z","steps":["trace[1949881313] 'agreement among raft nodes before linearized reading'  (duration: 255.174164ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:32:24.424209Z","caller":"traceutil/trace.go:171","msg":"trace[2094501322] transaction","detail":"{read_only:false; response_revision:11199; number_of_response:1; }","duration":"104.33033ms","start":"2026-08-19T09:32:24.319856Z","end":"2026-08-19T09:32:24.424187Z","steps":["trace[2094501322] 'process raft request'  (duration: 83.77344ms)","trace[2094501322] 'compare'  (duration: 20.311174ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:36:46.238324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10802}
{"level":"info","ts":"2026-08-19T09:36:46.311446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10802,"took":"71.341695ms","hash":1446719605,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":27987968,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-19T09:36:46.311508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1446719605,"revision":10802,"compact-revision":8301}
{"level":"warn","ts":"2026-08-19T09:38:14.814412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.993674ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13993704497654140701 > lease_revoke:<id:4233a0194a760db3>","response":"size:28"}
{"level":"info","ts":"2026-08-19T09:38:14.815205Z","caller":"traceutil/trace.go:171","msg":"trace[130136156] linearizableReadLoop","detail":"{readStateIndex:14060; appliedIndex:14058; }","duration":"118.334724ms","start":"2026-08-19T09:38:14.696839Z","end":"2026-08-19T09:38:14.815174Z","steps":["trace[130136156] 'read index received'  (duration: 117.440163ms)","trace[130136156] 'applied index is now lower than readState.Index'  (duration: 891.531µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:38:14.815213Z","caller":"traceutil/trace.go:171","msg":"trace[958358215] transaction","detail":"{read_only:false; response_revision:13592; number_of_response:1; }","duration":"148.241804ms","start":"2026-08-19T09:38:14.666942Z","end":"2026-08-19T09:38:14.815183Z","steps":["trace[958358215] 'process raft request'  (duration: 147.611059ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:38:14.816716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.859542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:38:14.81681Z","caller":"traceutil/trace.go:171","msg":"trace[532093511] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:13592; }","duration":"120.003135ms","start":"2026-08-19T09:38:14.696792Z","end":"2026-08-19T09:38:14.816795Z","steps":["trace[532093511] 'agreement among raft nodes before linearized reading'  (duration: 118.476498ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:38:49.20905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.568567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-pl9tb\" ","response":"range_response_count:1 size:12360"}
{"level":"info","ts":"2026-08-19T09:38:49.209146Z","caller":"traceutil/trace.go:171","msg":"trace[27216167] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-pl9tb; range_end:; response_count:1; response_revision:13790; }","duration":"140.729811ms","start":"2026-08-19T09:38:49.068397Z","end":"2026-08-19T09:38:49.209127Z","steps":["trace[27216167] 'range keys from in-memory index tree'  (duration: 140.372113ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:38:50.088858Z","caller":"traceutil/trace.go:171","msg":"trace[2044520402] linearizableReadLoop","detail":"{readStateIndex:14271; appliedIndex:14270; }","duration":"346.961275ms","start":"2026-08-19T09:38:49.741874Z","end":"2026-08-19T09:38:50.088835Z","steps":["trace[2044520402] 'read index received'  (duration: 346.846312ms)","trace[2044520402] 'applied index is now lower than readState.Index'  (duration: 113.663µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:38:50.089156Z","caller":"traceutil/trace.go:171","msg":"trace[1890267038] transaction","detail":"{read_only:false; response_revision:13794; number_of_response:1; }","duration":"411.617216ms","start":"2026-08-19T09:38:49.677528Z","end":"2026-08-19T09:38:50.089145Z","steps":["trace[1890267038] 'process raft request'  (duration: 411.164215ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:38:50.089263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:38:49.677504Z","time spent":"411.688418ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:13767 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T09:38:50.089517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.646351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T09:38:50.089558Z","caller":"traceutil/trace.go:171","msg":"trace[76937339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13794; }","duration":"347.723303ms","start":"2026-08-19T09:38:49.741825Z","end":"2026-08-19T09:38:50.089549Z","steps":["trace[76937339] 'agreement among raft nodes before linearized reading'  (duration: 347.60339ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:38:50.089592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:38:49.741806Z","time spent":"347.779754ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-19T09:38:50.089946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.188564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-08-19T09:38:50.09007Z","caller":"traceutil/trace.go:171","msg":"trace[1873665841] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:13794; }","duration":"110.307657ms","start":"2026-08-19T09:38:49.979698Z","end":"2026-08-19T09:38:50.090005Z","steps":["trace[1873665841] 'agreement among raft nodes before linearized reading'  (duration: 110.038641ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:38:59.144363Z","caller":"traceutil/trace.go:171","msg":"trace[2109199904] linearizableReadLoop","detail":"{readStateIndex:14438; appliedIndex:14437; }","duration":"127.521719ms","start":"2026-08-19T09:38:59.016813Z","end":"2026-08-19T09:38:59.144335Z","steps":["trace[2109199904] 'read index received'  (duration: 93.68563ms)","trace[2109199904] 'applied index is now lower than readState.Index'  (duration: 33.834289ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:38:59.144384Z","caller":"traceutil/trace.go:171","msg":"trace[2038379481] transaction","detail":"{read_only:false; response_revision:13959; number_of_response:1; }","duration":"166.470781ms","start":"2026-08-19T09:38:58.977878Z","end":"2026-08-19T09:38:59.144348Z","steps":["trace[2038379481] 'process raft request'  (duration: 132.581421ms)","trace[2038379481] 'compare'  (duration: 33.631143ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:38:59.144595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.773916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-19T09:38:59.144628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.681809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-19T09:38:59.14466Z","caller":"traceutil/trace.go:171","msg":"trace[584076336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13959; }","duration":"127.877087ms","start":"2026-08-19T09:38:59.016769Z","end":"2026-08-19T09:38:59.144646Z","steps":["trace[584076336] 'agreement among raft nodes before linearized reading'  (duration: 127.675922ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:38:59.14468Z","caller":"traceutil/trace.go:171","msg":"trace[895267927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13959; }","duration":"115.768122ms","start":"2026-08-19T09:38:59.028894Z","end":"2026-08-19T09:38:59.144662Z","steps":["trace[895267927] 'agreement among raft nodes before linearized reading'  (duration: 115.587507ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:40:39.840948Z","caller":"traceutil/trace.go:171","msg":"trace[1222022906] linearizableReadLoop","detail":"{readStateIndex:15562; appliedIndex:15561; }","duration":"463.295995ms","start":"2026-08-19T09:40:39.377554Z","end":"2026-08-19T09:40:39.84085Z","steps":["trace[1222022906] 'read index received'  (duration: 462.999348ms)","trace[1222022906] 'applied index is now lower than readState.Index'  (duration: 295.747µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:40:39.841147Z","caller":"traceutil/trace.go:171","msg":"trace[1431801340] transaction","detail":"{read_only:false; response_revision:15051; number_of_response:1; }","duration":"493.071313ms","start":"2026-08-19T09:40:39.348033Z","end":"2026-08-19T09:40:39.841105Z","steps":["trace[1431801340] 'process raft request'  (duration: 492.597832ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.841285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.663944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:40:39.841537Z","caller":"traceutil/trace.go:171","msg":"trace[824596234] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15051; }","duration":"464.010913ms","start":"2026-08-19T09:40:39.377511Z","end":"2026-08-19T09:40:39.841522Z","steps":["trace[824596234] 'agreement among raft nodes before linearized reading'  (duration: 463.663055ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.84156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.348013Z","time spent":"493.242678ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:15041 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-19T09:40:39.841664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.377497Z","time spent":"464.151496ms","remote":"127.0.0.1:55238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:40:39.841797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.57535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:40:39.841841Z","caller":"traceutil/trace.go:171","msg":"trace[1254817686] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15051; }","duration":"458.640141ms","start":"2026-08-19T09:40:39.383189Z","end":"2026-08-19T09:40:39.841829Z","steps":["trace[1254817686] 'agreement among raft nodes before linearized reading'  (duration: 458.561159ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.841875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.383178Z","time spent":"458.690621ms","remote":"127.0.0.1:55238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:40:39.842323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.001446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-08-19T09:40:39.842363Z","caller":"traceutil/trace.go:171","msg":"trace[1039079334] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15051; }","duration":"456.097808ms","start":"2026-08-19T09:40:39.386255Z","end":"2026-08-19T09:40:39.842353Z","steps":["trace[1039079334] 'agreement among raft nodes before linearized reading'  (duration: 455.989936ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.842395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.386219Z","time spent":"456.16917ms","remote":"127.0.0.1:55178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-08-19T09:40:39.842395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.063663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.18\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-08-19T09:40:39.842493Z","caller":"traceutil/trace.go:171","msg":"trace[1023945760] range","detail":"{range_begin:/registry/masterleases/199.19.213.18; range_end:; response_count:1; response_revision:15051; }","duration":"448.180806ms","start":"2026-08-19T09:40:39.394284Z","end":"2026-08-19T09:40:39.842464Z","steps":["trace[1023945760] 'agreement among raft nodes before linearized reading'  (duration: 447.863158ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.842557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.394275Z","time spent":"448.269248ms","remote":"127.0.0.1:55024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.18\" "}
{"level":"warn","ts":"2026-08-19T09:40:39.842643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.096545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-08-19T09:40:39.842683Z","caller":"traceutil/trace.go:171","msg":"trace[690751376] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15051; }","duration":"457.180667ms","start":"2026-08-19T09:40:39.385492Z","end":"2026-08-19T09:40:39.842672Z","steps":["trace[690751376] 'agreement among raft nodes before linearized reading'  (duration: 457.068643ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.842712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.38547Z","time spent":"457.236448ms","remote":"127.0.0.1:55238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-08-19T09:40:39.843087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.79958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-08-19T09:40:39.843152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.020368ms","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-08-19T09:40:39.84316Z","caller":"traceutil/trace.go:171","msg":"trace[416787002] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15051; }","duration":"459.911432ms","start":"2026-08-19T09:40:39.383236Z","end":"2026-08-19T09:40:39.843148Z","steps":["trace[416787002] 'agreement among raft nodes before linearized reading'  (duration: 459.780169ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:40:39.843192Z","caller":"traceutil/trace.go:171","msg":"trace[412487124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15051; }","duration":"193.157232ms","start":"2026-08-19T09:40:39.650024Z","end":"2026-08-19T09:40:39.843181Z","steps":["trace[412487124] 'agreement among raft nodes before linearized reading'  (duration: 192.990938ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.843195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.383223Z","time spent":"459.964733ms","remote":"127.0.0.1:55178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-08-19T09:40:39.843186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.526438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-08-19T09:40:39.843269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.515704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-19T09:40:39.843423Z","caller":"traceutil/trace.go:171","msg":"trace[992434223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15051; }","duration":"187.695568ms","start":"2026-08-19T09:40:39.655701Z","end":"2026-08-19T09:40:39.843397Z","steps":["trace[992434223] 'agreement among raft nodes before linearized reading'  (duration: 187.248488ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.843652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.201961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"info","ts":"2026-08-19T09:40:39.843698Z","caller":"traceutil/trace.go:171","msg":"trace[1197047716] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:15051; }","duration":"170.274062ms","start":"2026-08-19T09:40:39.673412Z","end":"2026-08-19T09:40:39.843686Z","steps":["trace[1197047716] 'agreement among raft nodes before linearized reading'  (duration: 170.16237ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.843667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.840926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8c997\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-08-19T09:40:39.843851Z","caller":"traceutil/trace.go:171","msg":"trace[691777859] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8c997; range_end:; response_count:1; response_revision:15051; }","duration":"153.048752ms","start":"2026-08-19T09:40:39.690785Z","end":"2026-08-19T09:40:39.843833Z","steps":["trace[691777859] 'agreement among raft nodes before linearized reading'  (duration: 152.740854ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:40:39.844349Z","caller":"traceutil/trace.go:171","msg":"trace[1153440901] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15051; }","duration":"458.638702ms","start":"2026-08-19T09:40:39.384609Z","end":"2026-08-19T09:40:39.843248Z","steps":["trace[1153440901] 'agreement among raft nodes before linearized reading'  (duration: 458.351945ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:39.844461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:40:39.384599Z","time spent":"459.84236ms","remote":"127.0.0.1:55238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-08-19T09:41:46.244007Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12977}
{"level":"info","ts":"2026-08-19T09:41:46.319151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12977,"took":"72.973514ms","hash":3903261128,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":31309824,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-19T09:41:46.319205Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3903261128,"revision":12977,"compact-revision":10802}
{"level":"info","ts":"2026-08-19T09:45:24.069786Z","caller":"traceutil/trace.go:171","msg":"trace[1524957559] transaction","detail":"{read_only:false; response_revision:17167; number_of_response:1; }","duration":"103.881009ms","start":"2026-08-19T09:45:23.965873Z","end":"2026-08-19T09:45:24.069754Z","steps":["trace[1524957559] 'process raft request'  (duration: 103.645843ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:17.517041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.641668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-08-19T09:46:17.517209Z","caller":"traceutil/trace.go:171","msg":"trace[2023985383] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:17607; }","duration":"196.854713ms","start":"2026-08-19T09:46:17.3203Z","end":"2026-08-19T09:46:17.517155Z","steps":["trace[2023985383] 'range keys from in-memory index tree'  (duration: 196.36282ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:46:24.585104Z","caller":"traceutil/trace.go:171","msg":"trace[1534560500] linearizableReadLoop","detail":"{readStateIndex:18257; appliedIndex:18256; }","duration":"129.014341ms","start":"2026-08-19T09:46:24.45606Z","end":"2026-08-19T09:46:24.585074Z","steps":["trace[1534560500] 'read index received'  (duration: 128.849857ms)","trace[1534560500] 'applied index is now lower than readState.Index'  (duration: 162.714µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:46:24.585223Z","caller":"traceutil/trace.go:171","msg":"trace[1078495216] transaction","detail":"{read_only:false; response_revision:17661; number_of_response:1; }","duration":"202.197573ms","start":"2026-08-19T09:46:24.382976Z","end":"2026-08-19T09:46:24.585173Z","steps":["trace[1078495216] 'process raft request'  (duration: 201.933357ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:24.585344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.264757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-19T09:46:24.585435Z","caller":"traceutil/trace.go:171","msg":"trace[1158417584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17661; }","duration":"129.39893ms","start":"2026-08-19T09:46:24.456016Z","end":"2026-08-19T09:46:24.585414Z","steps":["trace[1158417584] 'agreement among raft nodes before linearized reading'  (duration: 129.162394ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:46:24.591914Z","caller":"traceutil/trace.go:171","msg":"trace[750337520] transaction","detail":"{read_only:false; response_revision:17662; number_of_response:1; }","duration":"104.70957ms","start":"2026-08-19T09:46:24.487194Z","end":"2026-08-19T09:46:24.591904Z","steps":["trace[750337520] 'process raft request'  (duration: 104.515995ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:46:25.201598Z","caller":"traceutil/trace.go:171","msg":"trace[1810882875] linearizableReadLoop","detail":"{readStateIndex:18262; appliedIndex:18261; }","duration":"440.079295ms","start":"2026-08-19T09:46:24.761481Z","end":"2026-08-19T09:46:25.20156Z","steps":["trace[1810882875] 'read index received'  (duration: 439.755477ms)","trace[1810882875] 'applied index is now lower than readState.Index'  (duration: 322.658µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:46:25.20169Z","caller":"traceutil/trace.go:171","msg":"trace[1334842708] transaction","detail":"{read_only:false; response_revision:17666; number_of_response:1; }","duration":"481.256456ms","start":"2026-08-19T09:46:24.720399Z","end":"2026-08-19T09:46:25.201655Z","steps":["trace[1334842708] 'process raft request'  (duration: 480.907828ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:25.20185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:46:24.720362Z","time spent":"481.39904ms","remote":"127.0.0.1:55186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20867,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-z4lv9\" mod_revision:17565 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-z4lv9\" value_size:20803 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-z4lv9\" > >"}
{"level":"warn","ts":"2026-08-19T09:46:25.201829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.31234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:46:25.202047Z","caller":"traceutil/trace.go:171","msg":"trace[1844424382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17666; }","duration":"440.595638ms","start":"2026-08-19T09:46:24.761432Z","end":"2026-08-19T09:46:25.202028Z","steps":["trace[1844424382] 'agreement among raft nodes before linearized reading'  (duration: 440.31077ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:25.202143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:46:24.761412Z","time spent":"440.717772ms","remote":"127.0.0.1:53528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-19T09:46:25.306815Z","caller":"traceutil/trace.go:171","msg":"trace[43224680] transaction","detail":"{read_only:false; response_revision:17667; number_of_response:1; }","duration":"515.615245ms","start":"2026-08-19T09:46:24.791177Z","end":"2026-08-19T09:46:25.306792Z","steps":["trace[43224680] 'process raft request'  (duration: 515.333778ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:25.306963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:46:24.791145Z","time spent":"515.746867ms","remote":"127.0.0.1:55180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18736,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:17111 > success:<request_put:<key:\"/registry/minions/instance\" value_size:18700 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-08-19T09:46:25.307088Z","caller":"traceutil/trace.go:171","msg":"trace[972850928] linearizableReadLoop","detail":"{readStateIndex:18265; appliedIndex:18262; }","duration":"105.363746ms","start":"2026-08-19T09:46:25.201703Z","end":"2026-08-19T09:46:25.307066Z","steps":["trace[972850928] 'read index received'  (duration: 57.769857ms)","trace[972850928] 'applied index is now lower than readState.Index'  (duration: 47.589999ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:46:25.307137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.087582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:46:25.307124Z","caller":"traceutil/trace.go:171","msg":"trace[2006717047] transaction","detail":"{read_only:false; response_revision:17668; number_of_response:1; }","duration":"113.201466ms","start":"2026-08-19T09:46:25.193762Z","end":"2026-08-19T09:46:25.306963Z","steps":["trace[2006717047] 'process raft request'  (duration: 112.938869ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:46:25.307169Z","caller":"traceutil/trace.go:171","msg":"trace[515686505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17669; }","duration":"117.154393ms","start":"2026-08-19T09:46:25.190003Z","end":"2026-08-19T09:46:25.307157Z","steps":["trace[515686505] 'agreement among raft nodes before linearized reading'  (duration: 117.082512ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:25.307305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.326121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-h8z22\" ","response":"range_response_count:1 size:22122"}
{"level":"warn","ts":"2026-08-19T09:46:25.307301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.027069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-08-19T09:46:25.307374Z","caller":"traceutil/trace.go:171","msg":"trace[1036618028] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-h8z22; range_end:; response_count:1; response_revision:17669; }","duration":"438.455045ms","start":"2026-08-19T09:46:24.868906Z","end":"2026-08-19T09:46:25.307361Z","steps":["trace[1036618028] 'agreement among raft nodes before linearized reading'  (duration: 438.22851ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:46:25.307408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:46:24.868876Z","time spent":"438.524956ms","remote":"127.0.0.1:55186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22145,"request content":"key:\"/registry/pods/openstack/nova-compute-default-h8z22\" "}
{"level":"info","ts":"2026-08-19T09:46:25.307417Z","caller":"traceutil/trace.go:171","msg":"trace[1293074749] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:17669; }","duration":"140.177673ms","start":"2026-08-19T09:46:25.167217Z","end":"2026-08-19T09:46:25.307395Z","steps":["trace[1293074749] 'agreement among raft nodes before linearized reading'  (duration: 139.905787ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:46:46.249494Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15490}
{"level":"info","ts":"2026-08-19T09:46:46.34101Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15490,"took":"88.558336ms","hash":3429778750,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":32751616,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-19T09:46:46.341061Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3429778750,"revision":15490,"compact-revision":12977}
{"level":"info","ts":"2026-08-19T09:47:19.030977Z","caller":"traceutil/trace.go:171","msg":"trace[932967974] transaction","detail":"{read_only:false; response_revision:18297; number_of_response:1; }","duration":"111.787901ms","start":"2026-08-19T09:47:18.919162Z","end":"2026-08-19T09:47:19.030949Z","steps":["trace[932967974] 'process raft request'  (duration: 111.674359ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:49:58.776282Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d0358acb671c233","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T09:49:58.782023Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-19T09:49:58.782286Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-19T09:51:45.634023Z","caller":"traceutil/trace.go:171","msg":"trace[369418756] transaction","detail":"{read_only:false; response_revision:20126; number_of_response:1; }","duration":"303.837357ms","start":"2026-08-19T09:51:45.33015Z","end":"2026-08-19T09:51:45.633987Z","steps":["trace[369418756] 'process raft request'  (duration: 303.622602ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:45.634259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:51:45.330112Z","time spent":"304.035061ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:20116 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-19T09:51:45.950464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.633794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:51:45.950604Z","caller":"traceutil/trace.go:171","msg":"trace[969190240] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:20126; }","duration":"210.812529ms","start":"2026-08-19T09:51:45.739757Z","end":"2026-08-19T09:51:45.95057Z","steps":["trace[969190240] 'count revisions from in-memory index tree'  (duration: 210.478371ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:46.385421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.319491ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13993704497654162334 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:20118 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:51:46.385768Z","caller":"traceutil/trace.go:171","msg":"trace[2097314099] transaction","detail":"{read_only:false; response_revision:20128; number_of_response:1; }","duration":"243.959989ms","start":"2026-08-19T09:51:46.141771Z","end":"2026-08-19T09:51:46.385731Z","steps":["trace[2097314099] 'process raft request'  (duration: 96.233267ms)","trace[2097314099] 'compare'  (duration: 146.941002ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:51:46.386033Z","caller":"traceutil/trace.go:171","msg":"trace[1631659811] linearizableReadLoop","detail":"{readStateIndex:20806; appliedIndex:20805; }","duration":"236.414094ms","start":"2026-08-19T09:51:46.14958Z","end":"2026-08-19T09:51:46.385995Z","steps":["trace[1631659811] 'read index received'  (duration: 88.354124ms)","trace[1631659811] 'applied index is now lower than readState.Index'  (duration: 148.05737ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:51:46.386516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.922457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T09:51:46.386602Z","caller":"traceutil/trace.go:171","msg":"trace[570862349] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20128; }","duration":"237.06079ms","start":"2026-08-19T09:51:46.149528Z","end":"2026-08-19T09:51:46.386589Z","steps":["trace[570862349] 'agreement among raft nodes before linearized reading'  (duration: 236.830405ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:46.387468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.442038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:51:46.38751Z","caller":"traceutil/trace.go:171","msg":"trace[601975698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20129; }","duration":"198.53295ms","start":"2026-08-19T09:51:46.188962Z","end":"2026-08-19T09:51:46.387495Z","steps":["trace[601975698] 'agreement among raft nodes before linearized reading'  (duration: 198.450528ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:46.387804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:51:46.387914Z","caller":"traceutil/trace.go:171","msg":"trace[820020068] transaction","detail":"{read_only:false; response_revision:20129; number_of_response:1; }","duration":"135.968954ms","start":"2026-08-19T09:51:46.25192Z","end":"2026-08-19T09:51:46.387889Z","steps":["trace[820020068] 'process raft request'  (duration: 133.615317ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:51:46.387831Z","caller":"traceutil/trace.go:171","msg":"trace[628351668] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:20129; }","duration":"101.795492ms","start":"2026-08-19T09:51:46.286029Z","end":"2026-08-19T09:51:46.387824Z","steps":["trace[628351668] 'agreement among raft nodes before linearized reading'  (duration: 101.745241ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:51:46.775566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17864}
{"level":"warn","ts":"2026-08-19T09:51:46.777154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.762029ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13993704497654162339 username:\"kube-apiserver-etcd-client\" auth_revision:1 > compaction:<revision:17864 > ","response":"size:6"}
{"level":"info","ts":"2026-08-19T09:51:46.777294Z","caller":"traceutil/trace.go:171","msg":"trace[1163492193] compact","detail":"{revision:17864; response_revision:20129; }","duration":"388.013499ms","start":"2026-08-19T09:51:46.389265Z","end":"2026-08-19T09:51:46.777278Z","steps":["trace[1163492193] 'process raft request'  (duration: 128.309478ms)","trace[1163492193] 'check and update compact revision'  (duration: 255.763306ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:51:46.777332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:51:46.389196Z","time spent":"388.132631ms","remote":"127.0.0.1:53530","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-08-19T09:51:46.778391Z","caller":"traceutil/trace.go:171","msg":"trace[1269237389] transaction","detail":"{read_only:false; response_revision:20130; number_of_response:1; }","duration":"386.014011ms","start":"2026-08-19T09:51:46.392334Z","end":"2026-08-19T09:51:46.778348Z","steps":["trace[1269237389] 'process raft request'  (duration: 384.924534ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:46.778649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:51:46.392318Z","time spent":"386.217805ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:20120 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-19T09:51:46.77908Z","caller":"traceutil/trace.go:171","msg":"trace[1480168798] linearizableReadLoop","detail":"{readStateIndex:20810; appliedIndex:20807; }","duration":"332.481586ms","start":"2026-08-19T09:51:46.44657Z","end":"2026-08-19T09:51:46.779051Z","steps":["trace[1480168798] 'read index received'  (duration: 71.161355ms)","trace[1480168798] 'applied index is now lower than readState.Index'  (duration: 261.318981ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:51:46.779273Z","caller":"traceutil/trace.go:171","msg":"trace[2126042861] transaction","detail":"{read_only:false; response_revision:20131; number_of_response:1; }","duration":"384.818621ms","start":"2026-08-19T09:51:46.394433Z","end":"2026-08-19T09:51:46.779252Z","steps":["trace[2126042861] 'process raft request'  (duration: 383.882238ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:46.779464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:51:46.394421Z","time spent":"384.892393ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20119 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-08-19T09:51:46.779496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.907266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-19T09:51:46.779624Z","caller":"traceutil/trace.go:171","msg":"trace[2134150669] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20131; }","duration":"333.085921ms","start":"2026-08-19T09:51:46.446499Z","end":"2026-08-19T09:51:46.779585Z","steps":["trace[2134150669] 'agreement among raft nodes before linearized reading'  (duration: 332.776213ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:46.779683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:51:46.446478Z","time spent":"333.179262ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-19T09:51:46.78015Z","caller":"traceutil/trace.go:171","msg":"trace[402482028] transaction","detail":"{read_only:false; response_revision:20132; number_of_response:1; }","duration":"210.768458ms","start":"2026-08-19T09:51:46.569362Z","end":"2026-08-19T09:51:46.780131Z","steps":["trace[402482028] 'process raft request'  (duration: 209.62304ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:51:46.781008Z","caller":"traceutil/trace.go:171","msg":"trace[1080057080] transaction","detail":"{read_only:false; response_revision:20133; number_of_response:1; }","duration":"209.869236ms","start":"2026-08-19T09:51:46.571124Z","end":"2026-08-19T09:51:46.780993Z","steps":["trace[1080057080] 'process raft request'  (duration: 208.990224ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:51:47.048842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.478966ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13993704497654162346 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20121 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:51:47.048991Z","caller":"traceutil/trace.go:171","msg":"trace[1278268510] linearizableReadLoop","detail":"{readStateIndex:20813; appliedIndex:20812; }","duration":"155.90345ms","start":"2026-08-19T09:51:46.893063Z","end":"2026-08-19T09:51:47.048966Z","steps":["trace[1278268510] 'read index received'  (duration: 10.192458ms)","trace[1278268510] 'applied index is now lower than readState.Index'  (duration: 145.708492ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:51:47.049152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.093805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T09:51:47.049196Z","caller":"traceutil/trace.go:171","msg":"trace[1068019803] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:20134; }","duration":"156.214928ms","start":"2026-08-19T09:51:46.892964Z","end":"2026-08-19T09:51:47.049179Z","steps":["trace[1068019803] 'agreement among raft nodes before linearized reading'  (duration: 156.121666ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:51:47.049218Z","caller":"traceutil/trace.go:171","msg":"trace[113979048] transaction","detail":"{read_only:false; response_revision:20134; number_of_response:1; }","duration":"263.567356ms","start":"2026-08-19T09:51:46.785549Z","end":"2026-08-19T09:51:47.049116Z","steps":["trace[113979048] 'process raft request'  (duration: 117.671379ms)","trace[113979048] 'compare'  (duration: 142.488614ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:51:47.049285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.183545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T09:51:47.049453Z","caller":"traceutil/trace.go:171","msg":"trace[491849165] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:20134; }","duration":"142.421481ms","start":"2026-08-19T09:51:46.906999Z","end":"2026-08-19T09:51:47.04942Z","steps":["trace[491849165] 'agreement among raft nodes before linearized reading'  (duration: 142.184425ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:51:47.249285Z","caller":"traceutil/trace.go:171","msg":"trace[289812306] transaction","detail":"{read_only:false; response_revision:20135; number_of_response:1; }","duration":"108.399033ms","start":"2026-08-19T09:51:47.14085Z","end":"2026-08-19T09:51:47.249249Z","steps":["trace[289812306] 'process raft request'  (duration: 96.801811ms)","trace[289812306] 'compare'  (duration: 11.345126ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:51:47.42128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17864,"took":"638.66549ms","hash":189680390,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":30179328,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T09:51:47.421357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":189680390,"revision":17864,"compact-revision":15490}
{"level":"info","ts":"2026-08-19T09:55:42.221941Z","caller":"traceutil/trace.go:171","msg":"trace[1370678380] transaction","detail":"{read_only:false; response_revision:22570; number_of_response:1; }","duration":"177.311022ms","start":"2026-08-19T09:55:42.0446Z","end":"2026-08-19T09:55:42.221911Z","steps":["trace[1370678380] 'process raft request'  (duration: 177.132638ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:55:42.223523Z","caller":"traceutil/trace.go:171","msg":"trace[126805514] transaction","detail":"{read_only:false; response_revision:22571; number_of_response:1; }","duration":"175.338515ms","start":"2026-08-19T09:55:42.048143Z","end":"2026-08-19T09:55:42.223482Z","steps":["trace[126805514] 'process raft request'  (duration: 174.960126ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:56:46.783038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20129}
{"level":"info","ts":"2026-08-19T09:56:46.892483Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20129,"took":"104.1307ms","hash":2956288355,"current-db-size-bytes":58396672,"current-db-size":"58 MB","current-db-size-in-use-bytes":42954752,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-19T09:56:46.89257Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2956288355,"revision":20129,"compact-revision":17864}
{"level":"info","ts":"2026-08-19T10:01:46.78917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23296}
{"level":"info","ts":"2026-08-19T10:01:46.928695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23296,"took":"134.612959ms","hash":2135447112,"current-db-size-bytes":59240448,"current-db-size":"59 MB","current-db-size-in-use-bytes":32317440,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T10:01:46.928759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2135447112,"revision":23296,"compact-revision":20129}