{"level":"warn","ts":"2026-09-10T17:55:11.668541Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-10T17:55:11.66866Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.149: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://162.253.55.149:2380","--initial-cluster=instance=https://162.253.55.149:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.149:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.149: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-09-10T17:55:11.668743Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-10T17:55:11.668763Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.149:2380"]}
{"level":"info","ts":"2026-09-10T17:55:11.668786Z","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-09-10T17:55:11.669517Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"]}
{"level":"info","ts":"2026-09-10T17:55:11.669598Z","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://162.253.55.149:2380"],"listen-peer-urls":["https://162.253.55.149:2380"],"advertise-client-urls":["https://162.253.55.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.149: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-09-10T17:55:11.672568Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.736923ms"}
{"level":"info","ts":"2026-09-10T17:55:11.678898Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab61124f07c17f20","cluster-id":"c5f62e84ad801ad2"}
{"level":"info","ts":"2026-09-10T17:55:11.679031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-10T17:55:11.679068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 0"}
{"level":"info","ts":"2026-09-10T17:55:11.679079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab61124f07c17f20 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-10T17:55:11.679087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 1"}
{"level":"info","ts":"2026-09-10T17:55:11.679161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"}
{"level":"warn","ts":"2026-09-10T17:55:11.695588Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-10T17:55:11.697577Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-10T17:55:11.699117Z","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-09-10T17:55:11.701469Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab61124f07c17f20","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-10T17:55:11.701631Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab61124f07c17f20","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-10T17:55:11.701981Z","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-09-10T17:55:11.702123Z","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-09-10T17:55:11.702147Z","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-09-10T17:55:11.70416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"}
{"level":"info","ts":"2026-09-10T17:55:11.709428Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c5f62e84ad801ad2","local-member-id":"ab61124f07c17f20","added-peer-id":"ab61124f07c17f20","added-peer-peer-urls":["https://162.253.55.149:2380"]}
{"level":"info","ts":"2026-09-10T17:55:11.710692Z","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-09-10T17:55:11.710784Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.149:2380"}
{"level":"info","ts":"2026-09-10T17:55:11.710929Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.149:2380"}
{"level":"info","ts":"2026-09-10T17:55:11.711158Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab61124f07c17f20","initial-advertise-peer-urls":["https://162.253.55.149:2380"],"listen-peer-urls":["https://162.253.55.149:2380"],"advertise-client-urls":["https://162.253.55.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-10T17:55:11.711223Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-10T17:55:12.480159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-10T17:55:12.480236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-10T17:55:12.480267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgPreVoteResp from ab61124f07c17f20 at term 1"}
{"level":"info","ts":"2026-09-10T17:55:12.480282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became candidate at term 2"}
{"level":"info","ts":"2026-09-10T17:55:12.480288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgVoteResp from ab61124f07c17f20 at term 2"}
{"level":"info","ts":"2026-09-10T17:55:12.480298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became leader at term 2"}
{"level":"info","ts":"2026-09-10T17:55:12.480308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab61124f07c17f20 elected leader ab61124f07c17f20 at term 2"}
{"level":"info","ts":"2026-09-10T17:55:12.48181Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T17:55:12.482808Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab61124f07c17f20","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.149:2379]}","request-path":"/0/members/ab61124f07c17f20/attributes","cluster-id":"c5f62e84ad801ad2","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-10T17:55:12.482866Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-10T17:55:12.482988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-10T17:55:12.483337Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-10T17:55:12.483421Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-10T17:55:12.483382Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c5f62e84ad801ad2","local-member-id":"ab61124f07c17f20","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T17:55:12.483634Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T17:55:12.483702Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T17:55:12.48545Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.149:2379"}
{"level":"info","ts":"2026-09-10T17:55:12.486671Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-09-10T17:55:38.768769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.211296ms","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-09-10T17:55:38.768964Z","caller":"traceutil/trace.go:171","msg":"trace[720484514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:428; }","duration":"102.484293ms","start":"2026-09-10T17:55:38.666448Z","end":"2026-09-10T17:55:38.768933Z","steps":["trace[720484514] 'range keys from in-memory index tree'  (duration: 102.025591ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:56:00.097643Z","caller":"traceutil/trace.go:171","msg":"trace[41805761] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"157.804346ms","start":"2026-09-10T17:55:59.939812Z","end":"2026-09-10T17:56:00.097617Z","steps":["trace[41805761] 'process raft request'  (duration: 157.657012ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:56:00.171298Z","caller":"traceutil/trace.go:171","msg":"trace[535211263] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"195.488235ms","start":"2026-09-10T17:55:59.975774Z","end":"2026-09-10T17:56:00.171262Z","steps":["trace[535211263] 'process raft request'  (duration: 187.173385ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:56:00.577027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.362034ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200269329 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-10T17:56:00.577308Z","caller":"traceutil/trace.go:171","msg":"trace[1318575368] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"330.889559ms","start":"2026-09-10T17:56:00.246387Z","end":"2026-09-10T17:56:00.577276Z","steps":["trace[1318575368] 'process raft request'  (duration: 81.614271ms)","trace[1318575368] 'compare'  (duration: 248.151048ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:56:00.577694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:56:00.246349Z","time spent":"331.277729ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-09-10T17:56:01.172596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.176438ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200269336 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:590 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T17:56:01.172749Z","caller":"traceutil/trace.go:171","msg":"trace[1389251870] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"215.451163ms","start":"2026-09-10T17:56:00.957263Z","end":"2026-09-10T17:56:01.172714Z","steps":["trace[1389251870] 'read index received'  (duration: 79.882124ms)","trace[1389251870] 'applied index is now lower than readState.Index'  (duration: 135.566979ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:56:01.172932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.679929ms","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-09-10T17:56:01.17299Z","caller":"traceutil/trace.go:171","msg":"trace[213207503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"215.793252ms","start":"2026-09-10T17:56:00.957177Z","end":"2026-09-10T17:56:01.17297Z","steps":["trace[213207503] 'agreement among raft nodes before linearized reading'  (duration: 215.616988ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:56:01.173012Z","caller":"traceutil/trace.go:171","msg":"trace[642854863] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"524.627387ms","start":"2026-09-10T17:56:00.648345Z","end":"2026-09-10T17:56:01.172973Z","steps":["trace[642854863] 'process raft request'  (duration: 388.815062ms)","trace[642854863] 'compare'  (duration: 134.699296ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:56:01.173476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:56:00.648305Z","time spent":"524.918275ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:590 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-09-10T17:56:01.293624Z","caller":"traceutil/trace.go:171","msg":"trace[1125495425] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"115.522548ms","start":"2026-09-10T17:56:01.178074Z","end":"2026-09-10T17:56:01.293597Z","steps":["trace[1125495425] 'process raft request'  (duration: 115.434666ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:56:01.293648Z","caller":"traceutil/trace.go:171","msg":"trace[2128681872] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"260.389072ms","start":"2026-09-10T17:56:01.033221Z","end":"2026-09-10T17:56:01.29361Z","steps":["trace[2128681872] 'process raft request'  (duration: 256.763756ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:56:49.998402Z","caller":"traceutil/trace.go:171","msg":"trace[834592151] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"283.430903ms","start":"2026-09-10T17:56:49.714936Z","end":"2026-09-10T17:56:49.998367Z","steps":["trace[834592151] 'process raft request'  (duration: 283.218657ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:56:50.062648Z","caller":"traceutil/trace.go:171","msg":"trace[1360918856] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"120.024307ms","start":"2026-09-10T17:56:49.942601Z","end":"2026-09-10T17:56:50.062625Z","steps":["trace[1360918856] 'process raft request'  (duration: 119.826622ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:12.495455Z","caller":"traceutil/trace.go:171","msg":"trace[625340185] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"155.700621ms","start":"2026-09-10T17:57:12.339724Z","end":"2026-09-10T17:57:12.495425Z","steps":["trace[625340185] 'process raft request'  (duration: 155.459435ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:39.650492Z","caller":"traceutil/trace.go:171","msg":"trace[1200225151] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"188.480099ms","start":"2026-09-10T17:57:39.461974Z","end":"2026-09-10T17:57:39.650454Z","steps":["trace[1200225151] 'process raft request'  (duration: 187.252827ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:40.109321Z","caller":"traceutil/trace.go:171","msg":"trace[1461528520] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"448.120141ms","start":"2026-09-10T17:57:39.661169Z","end":"2026-09-10T17:57:40.109289Z","steps":["trace[1461528520] 'process raft request'  (duration: 447.895825ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:40.109507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:39.661133Z","time spent":"448.282826ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" mod_revision:1837 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" value_size:909 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" > >"}
{"level":"info","ts":"2026-09-10T17:57:40.109601Z","caller":"traceutil/trace.go:171","msg":"trace[1568550849] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"448.018499ms","start":"2026-09-10T17:57:39.661555Z","end":"2026-09-10T17:57:40.109573Z","steps":["trace[1568550849] 'process raft request'  (duration: 447.67771ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:40.109856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:39.661523Z","time spent":"448.237705ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-67bzb\" mod_revision:1836 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-67bzb\" value_size:1459 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-67bzb\" > >"}
{"level":"info","ts":"2026-09-10T17:57:40.109934Z","caller":"traceutil/trace.go:171","msg":"trace[1015970969] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"448.277256ms","start":"2026-09-10T17:57:39.661571Z","end":"2026-09-10T17:57:40.109848Z","steps":["trace[1015970969] 'process raft request'  (duration: 447.920817ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:40.110085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.751714ms","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-09-10T17:57:40.110116Z","caller":"traceutil/trace.go:171","msg":"trace[643662042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1875; }","duration":"302.823256ms","start":"2026-09-10T17:57:39.807284Z","end":"2026-09-10T17:57:40.110107Z","steps":["trace[643662042] 'agreement among raft nodes before linearized reading'  (duration: 302.709073ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:40.110171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:39.80726Z","time spent":"302.906138ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-10T17:57:40.110085Z","caller":"traceutil/trace.go:171","msg":"trace[1759573555] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1937; }","duration":"302.432035ms","start":"2026-09-10T17:57:39.807341Z","end":"2026-09-10T17:57:40.109773Z","steps":["trace[1759573555] 'read index received'  (duration: 301.772028ms)","trace[1759573555] 'applied index is now lower than readState.Index'  (duration: 659.057µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:57:40.110609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.890512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-09-10T17:57:40.110632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.80179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-10T17:57:40.110673Z","caller":"traceutil/trace.go:171","msg":"trace[1052539702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1875; }","duration":"278.994035ms","start":"2026-09-10T17:57:39.831658Z","end":"2026-09-10T17:57:40.110652Z","steps":["trace[1052539702] 'agreement among raft nodes before linearized reading'  (duration: 278.77268ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:40.110718Z","caller":"traceutil/trace.go:171","msg":"trace[1313796034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1875; }","duration":"207.933535ms","start":"2026-09-10T17:57:39.902762Z","end":"2026-09-10T17:57:40.110696Z","steps":["trace[1313796034] 'agreement among raft nodes before linearized reading'  (duration: 207.699518ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:40.110806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:39.661537Z","time spent":"448.563144ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-zl8wm\" mod_revision:1840 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-zl8wm\" value_size:1392 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-zl8wm\" > >"}
{"level":"info","ts":"2026-09-10T17:57:40.240595Z","caller":"traceutil/trace.go:171","msg":"trace[1531536389] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"126.127258ms","start":"2026-09-10T17:57:40.114446Z","end":"2026-09-10T17:57:40.240573Z","steps":["trace[1531536389] 'process raft request'  (duration: 126.032745ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:40.533362Z","caller":"traceutil/trace.go:171","msg":"trace[2072378932] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"223.529287ms","start":"2026-09-10T17:57:40.309811Z","end":"2026-09-10T17:57:40.533341Z","steps":["trace[2072378932] 'read index received'  (duration: 223.406484ms)","trace[2072378932] 'applied index is now lower than readState.Index'  (duration: 121.973µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:57:40.533666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.831395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-359be473-8d3a-450b-b2de-0e9368b8ea45\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-09-10T17:57:40.533709Z","caller":"traceutil/trace.go:171","msg":"trace[1924185282] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"249.798582ms","start":"2026-09-10T17:57:40.283721Z","end":"2026-09-10T17:57:40.533519Z","steps":["trace[1924185282] 'process raft request'  (duration: 249.463213ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:40.533738Z","caller":"traceutil/trace.go:171","msg":"trace[462146033] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-359be473-8d3a-450b-b2de-0e9368b8ea45; range_end:; response_count:1; response_revision:1878; }","duration":"223.947207ms","start":"2026-09-10T17:57:40.309778Z","end":"2026-09-10T17:57:40.533725Z","steps":["trace[462146033] 'agreement among raft nodes before linearized reading'  (duration: 223.65103ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:40.783467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.425003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200271861 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1858 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T17:57:40.783731Z","caller":"traceutil/trace.go:171","msg":"trace[751475357] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"302.033006ms","start":"2026-09-10T17:57:40.481674Z","end":"2026-09-10T17:57:40.783707Z","steps":["trace[751475357] 'process raft request'  (duration: 191.280894ms)","trace[751475357] 'compare'  (duration: 110.29948ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:57:40.783848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:40.48165Z","time spent":"302.129898ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1858 > 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-09-10T17:57:40.783869Z","caller":"traceutil/trace.go:171","msg":"trace[1593851753] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"150.642617ms","start":"2026-09-10T17:57:40.633199Z","end":"2026-09-10T17:57:40.783841Z","steps":["trace[1593851753] 'process raft request'  (duration: 150.410751ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:46.672827Z","caller":"traceutil/trace.go:171","msg":"trace[725903509] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2005; }","duration":"115.432836ms","start":"2026-09-10T17:57:46.55736Z","end":"2026-09-10T17:57:46.672793Z","steps":["trace[725903509] 'read index received'  (duration: 26.172964ms)","trace[725903509] 'applied index is now lower than readState.Index'  (duration: 89.258312ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:57:46.673134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.738854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-09-10T17:57:46.673251Z","caller":"traceutil/trace.go:171","msg":"trace[1844101186] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1941; }","duration":"115.897828ms","start":"2026-09-10T17:57:46.557329Z","end":"2026-09-10T17:57:46.673227Z","steps":["trace[1844101186] 'agreement among raft nodes before linearized reading'  (duration: 115.59231ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:46.673136Z","caller":"traceutil/trace.go:171","msg":"trace[1263150987] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"120.704715ms","start":"2026-09-10T17:57:46.552377Z","end":"2026-09-10T17:57:46.673081Z","steps":["trace[1263150987] 'process raft request'  (duration: 102.837502ms)","trace[1263150987] 'compare'  (duration: 17.400321ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T17:57:53.201564Z","caller":"traceutil/trace.go:171","msg":"trace[482717452] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"322.554958ms","start":"2026-09-10T17:57:52.878966Z","end":"2026-09-10T17:57:53.201521Z","steps":["trace[482717452] 'process raft request'  (duration: 322.388344ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:53.201727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:52.878942Z","time spent":"322.708552ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1968 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-10T17:57:53.245345Z","caller":"traceutil/trace.go:171","msg":"trace[6743586] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"329.356709ms","start":"2026-09-10T17:57:52.915955Z","end":"2026-09-10T17:57:53.245312Z","steps":["trace[6743586] 'process raft request'  (duration: 329.070671ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:57:53.245505Z","caller":"traceutil/trace.go:171","msg":"trace[2070685893] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"325.085405ms","start":"2026-09-10T17:57:52.920388Z","end":"2026-09-10T17:57:53.245474Z","steps":["trace[2070685893] 'process raft request'  (duration: 324.865839ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:53.245555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:52.915922Z","time spent":"329.535304ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1969 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-10T17:57:53.245369Z","caller":"traceutil/trace.go:171","msg":"trace[393632138] linearizableReadLoop","detail":"{readStateIndex:2052; appliedIndex:2050; }","duration":"325.351023ms","start":"2026-09-10T17:57:52.919957Z","end":"2026-09-10T17:57:53.245308Z","steps":["trace[393632138] 'read index received'  (duration: 281.460041ms)","trace[393632138] 'applied index is now lower than readState.Index'  (duration: 43.890002ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:57:53.24558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.581909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-tktrx\" ","response":"range_response_count:1 size:6141"}
{"level":"info","ts":"2026-09-10T17:57:53.245714Z","caller":"traceutil/trace.go:171","msg":"trace[1702378372] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-tktrx; range_end:; response_count:1; response_revision:1985; }","duration":"325.775984ms","start":"2026-09-10T17:57:52.919912Z","end":"2026-09-10T17:57:53.245688Z","steps":["trace[1702378372] 'agreement among raft nodes before linearized reading'  (duration: 325.511167ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:53.245796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:52.91989Z","time spent":"325.888297ms","remote":"127.0.0.1:59158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":6165,"request content":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-tktrx\" "}
{"level":"warn","ts":"2026-09-10T17:57:53.245855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.823305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11986"}
{"level":"info","ts":"2026-09-10T17:57:53.245915Z","caller":"traceutil/trace.go:171","msg":"trace[85786845] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1985; }","duration":"169.920297ms","start":"2026-09-10T17:57:53.07598Z","end":"2026-09-10T17:57:53.2459Z","steps":["trace[85786845] 'agreement among raft nodes before linearized reading'  (duration: 169.737222ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:57:53.246758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:57:52.920373Z","time spent":"325.191908ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1970 > 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-09-10T17:58:19.19797Z","caller":"traceutil/trace.go:171","msg":"trace[1607581584] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"140.129219ms","start":"2026-09-10T17:58:19.057818Z","end":"2026-09-10T17:58:19.197947Z","steps":["trace[1607581584] 'process raft request'  (duration: 139.936384ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:58:30.780042Z","caller":"traceutil/trace.go:171","msg":"trace[2128833844] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2273; }","duration":"184.709409ms","start":"2026-09-10T17:58:30.595304Z","end":"2026-09-10T17:58:30.780014Z","steps":["trace[2128833844] 'read index received'  (duration: 184.464263ms)","trace[2128833844] 'applied index is now lower than readState.Index'  (duration: 243.746µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T17:58:30.780125Z","caller":"traceutil/trace.go:171","msg":"trace[771586397] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"200.58866ms","start":"2026-09-10T17:58:30.579485Z","end":"2026-09-10T17:58:30.780074Z","steps":["trace[771586397] 'process raft request'  (duration: 200.346354ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:30.780275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.286221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-10T17:58:30.780322Z","caller":"traceutil/trace.go:171","msg":"trace[1478935726] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2198; }","duration":"169.410754ms","start":"2026-09-10T17:58:30.610899Z","end":"2026-09-10T17:58:30.78031Z","steps":["trace[1478935726] 'agreement among raft nodes before linearized reading'  (duration: 169.297381ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:30.780351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.051779ms","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-09-10T17:58:30.780405Z","caller":"traceutil/trace.go:171","msg":"trace[1625918270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2198; }","duration":"185.155772ms","start":"2026-09-10T17:58:30.595236Z","end":"2026-09-10T17:58:30.780392Z","steps":["trace[1625918270] 'agreement among raft nodes before linearized reading'  (duration: 184.953826ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:30.780439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.027849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-10T17:58:30.780544Z","caller":"traceutil/trace.go:171","msg":"trace[458645075] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2198; }","duration":"111.220884ms","start":"2026-09-10T17:58:30.669296Z","end":"2026-09-10T17:58:30.780517Z","steps":["trace[458645075] 'agreement among raft nodes before linearized reading'  (duration: 111.024259ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:58:30.967138Z","caller":"traceutil/trace.go:171","msg":"trace[1361093744] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"181.412182ms","start":"2026-09-10T17:58:30.785694Z","end":"2026-09-10T17:58:30.967107Z","steps":["trace[1361093744] 'process raft request'  (duration: 181.185216ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.115496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.746948ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200272612 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2194 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T17:58:32.115624Z","caller":"traceutil/trace.go:171","msg":"trace[663674712] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"698.337015ms","start":"2026-09-10T17:58:31.417259Z","end":"2026-09-10T17:58:32.115596Z","steps":["trace[663674712] 'process raft request'  (duration: 195.33193ms)","trace[663674712] 'compare'  (duration: 502.597184ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:58:32.115684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.417233Z","time spent":"698.421397ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2194 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-10T17:58:32.129149Z","caller":"traceutil/trace.go:171","msg":"trace[26933965] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"711.778731ms","start":"2026-09-10T17:58:31.41734Z","end":"2026-09-10T17:58:32.129119Z","steps":["trace[26933965] 'process raft request'  (duration: 711.548965ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.129384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.417293Z","time spent":"712.036568ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2193 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-10T17:58:32.346582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.510607ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200272614 > lease_revoke:<id:7f20a08c7596d01b>","response":"size:29"}
{"level":"info","ts":"2026-09-10T17:58:32.346732Z","caller":"traceutil/trace.go:171","msg":"trace[1979258667] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2277; }","duration":"902.300055ms","start":"2026-09-10T17:58:31.444406Z","end":"2026-09-10T17:58:32.346706Z","steps":["trace[1979258667] 'read index received'  (duration: 168.138471ms)","trace[1979258667] 'applied index is now lower than readState.Index'  (duration: 734.159754ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T17:58:32.347022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.605322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-10T17:58:32.347108Z","caller":"traceutil/trace.go:171","msg":"trace[1840541335] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2203; }","duration":"902.746087ms","start":"2026-09-10T17:58:31.444343Z","end":"2026-09-10T17:58:32.347089Z","steps":["trace[1840541335] 'agreement among raft nodes before linearized reading'  (duration: 902.50023ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.347148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.444317Z","time spent":"902.823098ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-10T17:58:32.359196Z","caller":"traceutil/trace.go:171","msg":"trace[1398638410] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"598.40676ms","start":"2026-09-10T17:58:31.760727Z","end":"2026-09-10T17:58:32.359134Z","steps":["trace[1398638410] 'process raft request'  (duration: 598.142063ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.359399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.760666Z","time spent":"598.621126ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2153 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-09-10T17:58:32.359505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.028059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-10T17:58:32.359533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.371487ms","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-09-10T17:58:32.359574Z","caller":"traceutil/trace.go:171","msg":"trace[1730377762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2205; }","duration":"213.123592ms","start":"2026-09-10T17:58:32.146433Z","end":"2026-09-10T17:58:32.359557Z","steps":["trace[1730377762] 'agreement among raft nodes before linearized reading'  (duration: 212.938617ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T17:58:32.359584Z","caller":"traceutil/trace.go:171","msg":"trace[703707734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2205; }","duration":"882.463859ms","start":"2026-09-10T17:58:31.477107Z","end":"2026-09-10T17:58:32.359571Z","steps":["trace[703707734] 'agreement among raft nodes before linearized reading'  (duration: 882.262234ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.359614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.477084Z","time spent":"882.522921ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-10T17:58:32.359601Z","caller":"traceutil/trace.go:171","msg":"trace[1462874012] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"375.90573ms","start":"2026-09-10T17:58:31.983673Z","end":"2026-09-10T17:58:32.359579Z","steps":["trace[1462874012] 'process raft request'  (duration: 375.405437ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.359745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.983643Z","time spent":"376.015363ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2165 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-09-10T17:58:32.359758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.738845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-10T17:58:32.35982Z","caller":"traceutil/trace.go:171","msg":"trace[252212146] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2205; }","duration":"823.836618ms","start":"2026-09-10T17:58:31.535961Z","end":"2026-09-10T17:58:32.359798Z","steps":["trace[252212146] 'agreement among raft nodes before linearized reading'  (duration: 823.606612ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.359765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.414886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-10T17:58:32.359868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.535939Z","time spent":"823.91985ms","remote":"127.0.0.1:60230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-10T17:58:32.359999Z","caller":"traceutil/trace.go:171","msg":"trace[1731302792] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2205; }","duration":"214.803696ms","start":"2026-09-10T17:58:32.145149Z","end":"2026-09-10T17:58:32.359952Z","steps":["trace[1731302792] 'agreement among raft nodes before linearized reading'  (duration: 214.391675ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.360269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.092323ms","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-09-10T17:58:32.360422Z","caller":"traceutil/trace.go:171","msg":"trace[49260833] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2205; }","duration":"708.31448ms","start":"2026-09-10T17:58:31.65208Z","end":"2026-09-10T17:58:32.360395Z","steps":["trace[49260833] 'agreement among raft nodes before linearized reading'  (duration: 707.328304ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:58:32.360519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:58:31.652048Z","time spent":"708.453673ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-10T17:59:26.917548Z","caller":"traceutil/trace.go:171","msg":"trace[1970919875] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2768; }","duration":"241.731845ms","start":"2026-09-10T17:59:26.675796Z","end":"2026-09-10T17:59:26.917528Z","steps":["trace[1970919875] 'read index received'  (duration: 241.565431ms)","trace[1970919875] 'applied index is now lower than readState.Index'  (duration: 165.504µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T17:59:26.917612Z","caller":"traceutil/trace.go:171","msg":"trace[1001611689] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"249.058709ms","start":"2026-09-10T17:59:26.668525Z","end":"2026-09-10T17:59:26.917584Z","steps":["trace[1001611689] 'process raft request'  (duration: 248.878134ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:59:26.917818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.988982ms","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-09-10T17:59:26.917917Z","caller":"traceutil/trace.go:171","msg":"trace[1613044628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2672; }","duration":"242.146246ms","start":"2026-09-10T17:59:26.675751Z","end":"2026-09-10T17:59:26.917897Z","steps":["trace[1613044628] 'agreement among raft nodes before linearized reading'  (duration: 241.89239ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T17:59:26.918345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.522268ms","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-09-10T17:59:26.91839Z","caller":"traceutil/trace.go:171","msg":"trace[1715502341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2672; }","duration":"240.090372ms","start":"2026-09-10T17:59:26.678289Z","end":"2026-09-10T17:59:26.91838Z","steps":["trace[1715502341] 'agreement among raft nodes before linearized reading'  (duration: 239.398474ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:00:02.866804Z","caller":"traceutil/trace.go:171","msg":"trace[1475406052] transaction","detail":"{read_only:false; response_revision:2886; number_of_response:1; }","duration":"402.636919ms","start":"2026-09-10T18:00:02.464144Z","end":"2026-09-10T18:00:02.866781Z","steps":["trace[1475406052] 'process raft request'  (duration: 402.494305ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:00:02.866943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:00:02.464122Z","time spent":"402.756703ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2843 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-09-10T18:00:02.956466Z","caller":"traceutil/trace.go:171","msg":"trace[630174264] transaction","detail":"{read_only:false; response_revision:2887; number_of_response:1; }","duration":"455.100583ms","start":"2026-09-10T18:00:02.501337Z","end":"2026-09-10T18:00:02.956438Z","steps":["trace[630174264] 'process raft request'  (duration: 404.722514ms)","trace[630174264] 'compare'  (duration: 50.189214ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:00:02.956615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:00:02.501317Z","time spent":"455.223906ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2875 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-10T18:00:02.956829Z","caller":"traceutil/trace.go:171","msg":"trace[1391437676] transaction","detail":"{read_only:false; response_revision:2888; number_of_response:1; }","duration":"403.083001ms","start":"2026-09-10T18:00:02.553654Z","end":"2026-09-10T18:00:02.956737Z","steps":["trace[1391437676] 'process raft request'  (duration: 402.732552ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:00:02.957224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:00:02.553634Z","time spent":"403.349758ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2876 > 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-09-10T18:03:24.61953Z","caller":"traceutil/trace.go:171","msg":"trace[64704998] transaction","detail":"{read_only:false; response_revision:4147; number_of_response:1; }","duration":"128.833517ms","start":"2026-09-10T18:03:24.490673Z","end":"2026-09-10T18:03:24.619506Z","steps":["trace[64704998] 'process raft request'  (duration: 128.491538ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:03:24.857239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.129379ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200277472 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4138 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:03:24.857357Z","caller":"traceutil/trace.go:171","msg":"trace[1004267224] linearizableReadLoop","detail":"{readStateIndex:4298; appliedIndex:4297; }","duration":"231.033612ms","start":"2026-09-10T18:03:24.626305Z","end":"2026-09-10T18:03:24.857339Z","steps":["trace[1004267224] 'read index received'  (duration: 105.664536ms)","trace[1004267224] 'applied index is now lower than readState.Index'  (duration: 125.367886ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:03:24.857422Z","caller":"traceutil/trace.go:171","msg":"trace[1169145669] transaction","detail":"{read_only:false; response_revision:4148; number_of_response:1; }","duration":"232.747237ms","start":"2026-09-10T18:03:24.624622Z","end":"2026-09-10T18:03:24.85737Z","steps":["trace[1169145669] 'process raft request'  (duration: 107.377881ms)","trace[1169145669] 'compare'  (duration: 125.004296ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:03:24.857507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.197136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-10T18:03:24.857693Z","caller":"traceutil/trace.go:171","msg":"trace[294023683] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4148; }","duration":"231.387762ms","start":"2026-09-10T18:03:24.626276Z","end":"2026-09-10T18:03:24.857664Z","steps":["trace[294023683] 'agreement among raft nodes before linearized reading'  (duration: 231.130575ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:03:24.879778Z","caller":"traceutil/trace.go:171","msg":"trace[783690072] transaction","detail":"{read_only:false; response_revision:4149; number_of_response:1; }","duration":"220.155815ms","start":"2026-09-10T18:03:24.659599Z","end":"2026-09-10T18:03:24.879755Z","steps":["trace[783690072] 'process raft request'  (duration: 220.041192ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:03:24.880066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.335682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gxz68\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-09-10T18:03:24.880116Z","caller":"traceutil/trace.go:171","msg":"trace[1516410172] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gxz68; range_end:; response_count:1; response_revision:4149; }","duration":"126.399673ms","start":"2026-09-10T18:03:24.753704Z","end":"2026-09-10T18:03:24.880103Z","steps":["trace[1516410172] 'agreement among raft nodes before linearized reading'  (duration: 126.217598ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:04:49.787563Z","caller":"traceutil/trace.go:171","msg":"trace[1328820605] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"117.118987ms","start":"2026-09-10T18:04:49.67041Z","end":"2026-09-10T18:04:49.787529Z","steps":["trace[1328820605] 'process raft request'  (duration: 94.865941ms)","trace[1328820605] 'compare'  (duration: 22.097962ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:04:56.942327Z","caller":"traceutil/trace.go:171","msg":"trace[292488513] linearizableReadLoop","detail":"{readStateIndex:5541; appliedIndex:5540; }","duration":"146.287247ms","start":"2026-09-10T18:04:56.796024Z","end":"2026-09-10T18:04:56.942312Z","steps":["trace[292488513] 'read index received'  (duration: 133.550301ms)","trace[292488513] 'applied index is now lower than readState.Index'  (duration: 12.733926ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:04:56.942478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.443691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-10T18:04:56.942495Z","caller":"traceutil/trace.go:171","msg":"trace[839180255] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5347; }","duration":"146.509542ms","start":"2026-09-10T18:04:56.79598Z","end":"2026-09-10T18:04:56.942489Z","steps":["trace[839180255] 'agreement among raft nodes before linearized reading'  (duration: 146.395569ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:04:56.942641Z","caller":"traceutil/trace.go:171","msg":"trace[1414547578] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"163.664304ms","start":"2026-09-10T18:04:56.778968Z","end":"2026-09-10T18:04:56.942632Z","steps":["trace[1414547578] 'process raft request'  (duration: 150.6181ms)","trace[1414547578] 'compare'  (duration: 12.485369ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:04:59.203538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.222395ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200280243 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5351 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:04:59.203666Z","caller":"traceutil/trace.go:171","msg":"trace[1047614250] linearizableReadLoop","detail":"{readStateIndex:5579; appliedIndex:5577; }","duration":"167.269441ms","start":"2026-09-10T18:04:59.036384Z","end":"2026-09-10T18:04:59.203653Z","steps":["trace[1047614250] 'read index received'  (duration: 6.938363ms)","trace[1047614250] 'applied index is now lower than readState.Index'  (duration: 160.330398ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:04:59.20373Z","caller":"traceutil/trace.go:171","msg":"trace[2033896470] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"178.464865ms","start":"2026-09-10T18:04:59.025257Z","end":"2026-09-10T18:04:59.203722Z","steps":["trace[2033896470] 'process raft request'  (duration: 178.356793ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:04:59.20379Z","caller":"traceutil/trace.go:171","msg":"trace[1331850230] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"178.823235ms","start":"2026-09-10T18:04:59.024956Z","end":"2026-09-10T18:04:59.20378Z","steps":["trace[1331850230] 'process raft request'  (duration: 18.299322ms)","trace[1331850230] 'compare'  (duration: 160.136613ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:04:59.203838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.460576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:04:59.20387Z","caller":"traceutil/trace.go:171","msg":"trace[1975653773] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:5383; }","duration":"167.533398ms","start":"2026-09-10T18:04:59.036326Z","end":"2026-09-10T18:04:59.20386Z","steps":["trace[1975653773] 'agreement among raft nodes before linearized reading'  (duration: 167.484137ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:12.349154Z","caller":"traceutil/trace.go:171","msg":"trace[824551192] linearizableReadLoop","detail":"{readStateIndex:5815; appliedIndex:5812; }","duration":"110.134985ms","start":"2026-09-10T18:05:12.238996Z","end":"2026-09-10T18:05:12.349131Z","steps":["trace[824551192] 'read index received'  (duration: 8.081334ms)","trace[824551192] 'applied index is now lower than readState.Index'  (duration: 102.052501ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:05:12.349477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.451843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-10T18:05:12.349472Z","caller":"traceutil/trace.go:171","msg":"trace[659790060] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"118.442503ms","start":"2026-09-10T18:05:12.231007Z","end":"2026-09-10T18:05:12.349449Z","steps":["trace[659790060] 'process raft request'  (duration: 65.166888ms)","trace[659790060] 'compare'  (duration: 52.640748ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:05:12.349529Z","caller":"traceutil/trace.go:171","msg":"trace[1782790381] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5613; }","duration":"110.563726ms","start":"2026-09-10T18:05:12.238951Z","end":"2026-09-10T18:05:12.349514Z","steps":["trace[1782790381] 'agreement among raft nodes before linearized reading'  (duration: 110.3475ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:12.349644Z","caller":"traceutil/trace.go:171","msg":"trace[1443436522] transaction","detail":"{read_only:false; response_revision:5612; number_of_response:1; }","duration":"116.277286ms","start":"2026-09-10T18:05:12.233328Z","end":"2026-09-10T18:05:12.349605Z","steps":["trace[1443436522] 'process raft request'  (duration: 115.690571ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:12.349772Z","caller":"traceutil/trace.go:171","msg":"trace[1352065726] transaction","detail":"{read_only:false; response_revision:5613; number_of_response:1; }","duration":"108.808579ms","start":"2026-09-10T18:05:12.240899Z","end":"2026-09-10T18:05:12.349708Z","steps":["trace[1352065726] 'process raft request'  (duration: 108.181492ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:05:12.876659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.248548ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200280773 username:\"kube-apiserver-etcd-client\" auth_revision:1 > compaction:<revision:2940 > ","response":"size:5"}
{"level":"info","ts":"2026-09-10T18:05:12.876933Z","caller":"traceutil/trace.go:171","msg":"trace[1615373132] transaction","detail":"{read_only:false; response_revision:5615; number_of_response:1; }","duration":"297.948516ms","start":"2026-09-10T18:05:12.57896Z","end":"2026-09-10T18:05:12.876909Z","steps":["trace[1615373132] 'process raft request'  (duration: 297.810002ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:12.877413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2940}
{"level":"info","ts":"2026-09-10T18:05:12.877406Z","caller":"traceutil/trace.go:171","msg":"trace[1047362366] compact","detail":"{revision:2940; response_revision:5615; }","duration":"336.462332ms","start":"2026-09-10T18:05:12.540913Z","end":"2026-09-10T18:05:12.877376Z","steps":["trace[1047362366] 'check and update compact revision'  (duration: 321.652471ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:05:12.877639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:05:12.540893Z","time spent":"336.628736ms","remote":"127.0.0.1:58966","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-09-10T18:05:12.911063Z","caller":"traceutil/trace.go:171","msg":"trace[1357284793] transaction","detail":"{read_only:false; response_revision:5616; number_of_response:1; }","duration":"168.432882ms","start":"2026-09-10T18:05:12.742597Z","end":"2026-09-10T18:05:12.91103Z","steps":["trace[1357284793] 'process raft request'  (duration: 138.863242ms)","trace[1357284793] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; req_size:541; } (duration: 29.345484ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:05:12.966112Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2940,"took":"86.06832ms","hash":1416216175,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":31461376,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-10T18:05:12.966167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1416216175,"revision":2940,"compact-revision":-1}
{"level":"warn","ts":"2026-09-10T18:05:20.17453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.327167ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200281196 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:5563 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:05:20.174677Z","caller":"traceutil/trace.go:171","msg":"trace[759268760] linearizableReadLoop","detail":"{readStateIndex:5997; appliedIndex:5996; }","duration":"105.961135ms","start":"2026-09-10T18:05:20.068698Z","end":"2026-09-10T18:05:20.174659Z","steps":["trace[759268760] 'read index received'  (duration: 97.783µs)","trace[759268760] 'applied index is now lower than readState.Index'  (duration: 105.862382ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:05:20.174781Z","caller":"traceutil/trace.go:171","msg":"trace[1561995503] transaction","detail":"{read_only:false; response_revision:5790; number_of_response:1; }","duration":"169.470477ms","start":"2026-09-10T18:05:20.00526Z","end":"2026-09-10T18:05:20.17473Z","steps":["trace[1561995503] 'process raft request'  (duration: 54.861093ms)","trace[1561995503] 'compare'  (duration: 114.197033ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:05:20.174946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.240232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a008b144-4353-45ef-82b1-af8a5ec1356b\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-09-10T18:05:20.174998Z","caller":"traceutil/trace.go:171","msg":"trace[894145371] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a008b144-4353-45ef-82b1-af8a5ec1356b; range_end:; response_count:1; response_revision:5790; }","duration":"106.330825ms","start":"2026-09-10T18:05:20.068652Z","end":"2026-09-10T18:05:20.174982Z","steps":["trace[894145371] 'agreement among raft nodes before linearized reading'  (duration: 106.170971ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.400786Z","caller":"traceutil/trace.go:171","msg":"trace[148014975] transaction","detail":"{read_only:false; response_revision:5792; number_of_response:1; }","duration":"137.329456ms","start":"2026-09-10T18:05:20.263433Z","end":"2026-09-10T18:05:20.400762Z","steps":["trace[148014975] 'process raft request'  (duration: 137.170942ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:05:20.660745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.899613ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200281204 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5719 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:05:20.661019Z","caller":"traceutil/trace.go:171","msg":"trace[639712815] transaction","detail":"{read_only:false; response_revision:5794; number_of_response:1; }","duration":"282.564871ms","start":"2026-09-10T18:05:20.378428Z","end":"2026-09-10T18:05:20.660993Z","steps":["trace[639712815] 'process raft request'  (duration: 282.439988ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.66114Z","caller":"traceutil/trace.go:171","msg":"trace[1000361418] transaction","detail":"{read_only:false; response_revision:5793; number_of_response:1; }","duration":"284.38748ms","start":"2026-09-10T18:05:20.376683Z","end":"2026-09-10T18:05:20.661071Z","steps":["trace[1000361418] 'process raft request'  (duration: 158.004584ms)","trace[1000361418] 'compare'  (duration: 125.722129ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:05:20.682239Z","caller":"traceutil/trace.go:171","msg":"trace[485798827] transaction","detail":"{read_only:false; response_revision:5795; number_of_response:1; }","duration":"275.544106ms","start":"2026-09-10T18:05:20.40664Z","end":"2026-09-10T18:05:20.682184Z","steps":["trace[485798827] 'process raft request'  (duration: 275.29752ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.682248Z","caller":"traceutil/trace.go:171","msg":"trace[1733326978] transaction","detail":"{read_only:false; response_revision:5797; number_of_response:1; }","duration":"274.752555ms","start":"2026-09-10T18:05:20.407446Z","end":"2026-09-10T18:05:20.682198Z","steps":["trace[1733326978] 'process raft request'  (duration: 274.686643ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.682299Z","caller":"traceutil/trace.go:171","msg":"trace[1301244542] transaction","detail":"{read_only:false; response_revision:5796; number_of_response:1; }","duration":"275.499825ms","start":"2026-09-10T18:05:20.406737Z","end":"2026-09-10T18:05:20.682237Z","steps":["trace[1301244542] 'process raft request'  (duration: 275.352311ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.682802Z","caller":"traceutil/trace.go:171","msg":"trace[1022532124] transaction","detail":"{read_only:false; response_revision:5798; number_of_response:1; }","duration":"275.31174ms","start":"2026-09-10T18:05:20.407463Z","end":"2026-09-10T18:05:20.682774Z","steps":["trace[1022532124] 'process raft request'  (duration: 274.719724ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.682859Z","caller":"traceutil/trace.go:171","msg":"trace[1127327896] transaction","detail":"{read_only:false; response_revision:5800; number_of_response:1; }","duration":"274.369115ms","start":"2026-09-10T18:05:20.40847Z","end":"2026-09-10T18:05:20.682839Z","steps":["trace[1127327896] 'process raft request'  (duration: 274.300533ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:05:20.682993Z","caller":"traceutil/trace.go:171","msg":"trace[641681586] transaction","detail":"{read_only:false; response_revision:5799; number_of_response:1; }","duration":"275.126955ms","start":"2026-09-10T18:05:20.40785Z","end":"2026-09-10T18:05:20.682977Z","steps":["trace[641681586] 'process raft request'  (duration: 274.860058ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:05:31.836863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.472894ms","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:5"}
{"level":"info","ts":"2026-09-10T18:05:31.836953Z","caller":"traceutil/trace.go:171","msg":"trace[2049762039] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:5944; }","duration":"116.619158ms","start":"2026-09-10T18:05:31.720314Z","end":"2026-09-10T18:05:31.836933Z","steps":["trace[2049762039] 'count revisions from in-memory index tree'  (duration: 116.400892ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:10:12.886748Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5614}
{"level":"info","ts":"2026-09-10T18:10:12.981948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5614,"took":"93.361603ms","hash":532271458,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":27508736,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-10T18:10:12.982032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":532271458,"revision":5614,"compact-revision":2940}
{"level":"info","ts":"2026-09-10T18:11:48.907945Z","caller":"traceutil/trace.go:171","msg":"trace[655758309] transaction","detail":"{read_only:false; response_revision:8734; number_of_response:1; }","duration":"262.937806ms","start":"2026-09-10T18:11:48.644982Z","end":"2026-09-10T18:11:48.90792Z","steps":["trace[655758309] 'process raft request'  (duration: 260.940283ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:11:49.13153Z","caller":"traceutil/trace.go:171","msg":"trace[727049721] transaction","detail":"{read_only:false; response_revision:8735; number_of_response:1; }","duration":"315.375826ms","start":"2026-09-10T18:11:48.81612Z","end":"2026-09-10T18:11:49.131495Z","steps":["trace[727049721] 'process raft request'  (duration: 310.588919ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:11:49.131704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:11:48.81609Z","time spent":"315.52509ms","remote":"127.0.0.1:59142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20212,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:8077 > success:<request_put:<key:\"/registry/minions/instance\" value_size:20176 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-09-10T18:11:52.905966Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002363.wal"}
{"level":"warn","ts":"2026-09-10T18:12:01.849735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.821648ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200289015 > lease_revoke:<id:7f20a08c75970fe7>","response":"size:29"}
{"level":"info","ts":"2026-09-10T18:12:01.849998Z","caller":"traceutil/trace.go:171","msg":"trace[373284371] linearizableReadLoop","detail":"{readStateIndex:9106; appliedIndex:9104; }","duration":"249.352296ms","start":"2026-09-10T18:12:01.600626Z","end":"2026-09-10T18:12:01.849978Z","steps":["trace[373284371] 'read index received'  (duration: 183.484801ms)","trace[373284371] 'applied index is now lower than readState.Index'  (duration: 65.866435ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:12:01.850133Z","caller":"traceutil/trace.go:171","msg":"trace[1646983002] transaction","detail":"{read_only:false; response_revision:8801; number_of_response:1; }","duration":"385.36741ms","start":"2026-09-10T18:12:01.464722Z","end":"2026-09-10T18:12:01.85009Z","steps":["trace[1646983002] 'process raft request'  (duration: 385.127074ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:12:01.850236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.597984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-10T18:12:01.850322Z","caller":"traceutil/trace.go:171","msg":"trace[1338650178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8801; }","duration":"249.747037ms","start":"2026-09-10T18:12:01.60055Z","end":"2026-09-10T18:12:01.850297Z","steps":["trace[1338650178] 'agreement among raft nodes before linearized reading'  (duration: 249.540201ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:12:01.850419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:12:01.464686Z","time spent":"385.575696ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8791 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-09-10T18:12:01.850652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.71339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-09-10T18:12:01.850798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.287888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:12:01.850888Z","caller":"traceutil/trace.go:171","msg":"trace[1357850863] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8801; }","duration":"171.401831ms","start":"2026-09-10T18:12:01.679465Z","end":"2026-09-10T18:12:01.850867Z","steps":["trace[1357850863] 'agreement among raft nodes before linearized reading'  (duration: 171.220386ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:12:01.850724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.590697ms","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-09-10T18:12:01.851183Z","caller":"traceutil/trace.go:171","msg":"trace[1639316716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8801; }","duration":"115.08119ms","start":"2026-09-10T18:12:01.736078Z","end":"2026-09-10T18:12:01.85116Z","steps":["trace[1639316716] 'agreement among raft nodes before linearized reading'  (duration: 114.527775ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:12:01.851391Z","caller":"traceutil/trace.go:171","msg":"trace[1911638084] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8801; }","duration":"246.554393ms","start":"2026-09-10T18:12:01.604762Z","end":"2026-09-10T18:12:01.851316Z","steps":["trace[1911638084] 'agreement among raft nodes before linearized reading'  (duration: 245.551166ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:12:31.440017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.798717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:12:31.440128Z","caller":"traceutil/trace.go:171","msg":"trace[80772901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9014; }","duration":"292.9594ms","start":"2026-09-10T18:12:31.147148Z","end":"2026-09-10T18:12:31.440107Z","steps":["trace[80772901] 'range keys from in-memory index tree'  (duration: 292.630313ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:12:43.343904Z","caller":"traceutil/trace.go:171","msg":"trace[365051706] transaction","detail":"{read_only:false; response_revision:9077; number_of_response:1; }","duration":"145.933906ms","start":"2026-09-10T18:12:43.197944Z","end":"2026-09-10T18:12:43.343878Z","steps":["trace[365051706] 'process raft request'  (duration: 145.771512ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:12:43.672876Z","caller":"traceutil/trace.go:171","msg":"trace[206049975] transaction","detail":"{read_only:false; response_revision:9078; number_of_response:1; }","duration":"186.0664ms","start":"2026-09-10T18:12:43.486786Z","end":"2026-09-10T18:12:43.672853Z","steps":["trace[206049975] 'process raft request'  (duration: 185.912935ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:12:44.627359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.177038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gxz68\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-09-10T18:12:44.62747Z","caller":"traceutil/trace.go:171","msg":"trace[375142541] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gxz68; range_end:; response_count:1; response_revision:9084; }","duration":"196.333242ms","start":"2026-09-10T18:12:44.431114Z","end":"2026-09-10T18:12:44.627447Z","steps":["trace[375142541] 'range keys from in-memory index tree'  (duration: 195.980842ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:13:46.876436Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T18:13:46.884481Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-10T18:13:46.884627Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-10T18:15:12.895006Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7977}
{"level":"info","ts":"2026-09-10T18:15:12.992124Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7977,"took":"94.048705ms","hash":2465370409,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":24793088,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-09-10T18:15:12.992216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2465370409,"revision":7977,"compact-revision":5614}
{"level":"info","ts":"2026-09-10T18:19:38.256703Z","caller":"traceutil/trace.go:171","msg":"trace[33029645] transaction","detail":"{read_only:false; response_revision:12293; number_of_response:1; }","duration":"103.400269ms","start":"2026-09-10T18:19:38.153276Z","end":"2026-09-10T18:19:38.256676Z","steps":["trace[33029645] 'process raft request'  (duration: 103.206834ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:19:59.049308Z","caller":"traceutil/trace.go:171","msg":"trace[1975157662] transaction","detail":"{read_only:false; response_revision:12411; number_of_response:1; }","duration":"282.017435ms","start":"2026-09-10T18:19:58.767243Z","end":"2026-09-10T18:19:59.04926Z","steps":["trace[1975157662] 'process raft request'  (duration: 281.570843ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.049899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.321182ms","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-09-10T18:19:59.049981Z","caller":"traceutil/trace.go:171","msg":"trace[1340888862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12411; }","duration":"165.468396ms","start":"2026-09-10T18:19:58.884493Z","end":"2026-09-10T18:19:59.049962Z","steps":["trace[1340888862] 'agreement among raft nodes before linearized reading'  (duration: 165.218239ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:19:59.0558Z","caller":"traceutil/trace.go:171","msg":"trace[1637380915] linearizableReadLoop","detail":"{readStateIndex:12833; appliedIndex:12833; }","duration":"165.012783ms","start":"2026-09-10T18:19:58.884551Z","end":"2026-09-10T18:19:59.049564Z","steps":["trace[1637380915] 'read index received'  (duration: 164.994262ms)","trace[1637380915] 'applied index is now lower than readState.Index'  (duration: 14.491µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:19:59.056154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.358941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:19:59.056216Z","caller":"traceutil/trace.go:171","msg":"trace[1446546067] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12411; }","duration":"102.448694ms","start":"2026-09-10T18:19:58.953753Z","end":"2026-09-10T18:19:59.056202Z","steps":["trace[1446546067] 'agreement among raft nodes before linearized reading'  (duration: 102.339291ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.056426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.618469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:19:59.056561Z","caller":"traceutil/trace.go:171","msg":"trace[677451481] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12411; }","duration":"102.853405ms","start":"2026-09-10T18:19:58.95369Z","end":"2026-09-10T18:19:59.056543Z","steps":["trace[677451481] 'agreement among raft nodes before linearized reading'  (duration: 102.514056ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.056694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.250542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"}
{"level":"warn","ts":"2026-09-10T18:19:59.05671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.287457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-10T18:19:59.056985Z","caller":"traceutil/trace.go:171","msg":"trace[880711306] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12411; }","duration":"142.973486ms","start":"2026-09-10T18:19:58.913992Z","end":"2026-09-10T18:19:59.056966Z","steps":["trace[880711306] 'agreement among raft nodes before linearized reading'  (duration: 142.081622ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:19:59.056739Z","caller":"traceutil/trace.go:171","msg":"trace[537744436] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12411; }","duration":"104.372125ms","start":"2026-09-10T18:19:58.952353Z","end":"2026-09-10T18:19:59.056725Z","steps":["trace[537744436] 'agreement among raft nodes before linearized reading'  (duration: 104.243912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.056762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.449127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-10T18:19:59.056996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.169943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:19:59.057151Z","caller":"traceutil/trace.go:171","msg":"trace[628549172] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12411; }","duration":"104.875009ms","start":"2026-09-10T18:19:58.952245Z","end":"2026-09-10T18:19:59.05712Z","steps":["trace[628549172] 'agreement among raft nodes before linearized reading'  (duration: 104.476848ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:19:59.057173Z","caller":"traceutil/trace.go:171","msg":"trace[778297955] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12411; }","duration":"103.414949ms","start":"2026-09-10T18:19:58.953729Z","end":"2026-09-10T18:19:59.057144Z","steps":["trace[778297955] 'agreement among raft nodes before linearized reading'  (duration: 103.031329ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.237132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.686837ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200298788 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:12402 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:19:59.237468Z","caller":"traceutil/trace.go:171","msg":"trace[2146251910] transaction","detail":"{read_only:false; response_revision:12414; number_of_response:1; }","duration":"167.122589ms","start":"2026-09-10T18:19:59.070318Z","end":"2026-09-10T18:19:59.237441Z","steps":["trace[2146251910] 'process raft request'  (duration: 166.950244ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:19:59.237575Z","caller":"traceutil/trace.go:171","msg":"trace[480158112] linearizableReadLoop","detail":"{readStateIndex:12836; appliedIndex:12833; }","duration":"165.571588ms","start":"2026-09-10T18:19:59.071967Z","end":"2026-09-10T18:19:59.237539Z","steps":["trace[480158112] 'read index received'  (duration: 9.554965ms)","trace[480158112] 'applied index is now lower than readState.Index'  (duration: 156.014212ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:19:59.23757Z","caller":"traceutil/trace.go:171","msg":"trace[2052864687] transaction","detail":"{read_only:false; response_revision:12413; number_of_response:1; }","duration":"169.142043ms","start":"2026-09-10T18:19:59.068333Z","end":"2026-09-10T18:19:59.237475Z","steps":["trace[2052864687] 'process raft request'  (duration: 49.978853ms)","trace[2052864687] 'compare'  (duration: 118.509642ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:19:59.237717Z","caller":"traceutil/trace.go:171","msg":"trace[1667770592] transaction","detail":"{read_only:false; response_revision:12415; number_of_response:1; }","duration":"165.013873ms","start":"2026-09-10T18:19:59.072671Z","end":"2026-09-10T18:19:59.237685Z","steps":["trace[1667770592] 'process raft request'  (duration: 164.684515ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.237912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.916607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19922"}
{"level":"info","ts":"2026-09-10T18:19:59.23797Z","caller":"traceutil/trace.go:171","msg":"trace[1055110688] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:12415; }","duration":"166.048391ms","start":"2026-09-10T18:19:59.071907Z","end":"2026-09-10T18:19:59.237955Z","steps":["trace[1055110688] 'agreement among raft nodes before linearized reading'  (duration: 165.806654ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.238079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.044656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-10T18:19:59.238157Z","caller":"traceutil/trace.go:171","msg":"trace[992836024] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:12415; }","duration":"122.164859ms","start":"2026-09-10T18:19:59.11597Z","end":"2026-09-10T18:19:59.238134Z","steps":["trace[992836024] 'agreement among raft nodes before linearized reading'  (duration: 121.957814ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:19:59.238122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.92171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T18:19:59.238519Z","caller":"traceutil/trace.go:171","msg":"trace[778035890] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:12415; }","duration":"129.440144ms","start":"2026-09-10T18:19:59.109047Z","end":"2026-09-10T18:19:59.238488Z","steps":["trace[778035890] 'agreement among raft nodes before linearized reading'  (duration: 128.865338ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:20:12.903852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10344}
{"level":"info","ts":"2026-09-10T18:20:12.994704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10344,"took":"88.160793ms","hash":3782937264,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":25726976,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-10T18:20:12.994782Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3782937264,"revision":10344,"compact-revision":7977}
{"level":"info","ts":"2026-09-10T18:25:12.919797Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12522}
{"level":"info","ts":"2026-09-10T18:25:13.012608Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12522,"took":"89.992632ms","hash":4127216467,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":28139520,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-10T18:25:13.012706Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4127216467,"revision":12522,"compact-revision":10344}
{"level":"warn","ts":"2026-09-10T18:26:41.901061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.947317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-10T18:26:41.901151Z","caller":"traceutil/trace.go:171","msg":"trace[167597643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15073; }","duration":"154.05451ms","start":"2026-09-10T18:26:41.74708Z","end":"2026-09-10T18:26:41.901134Z","steps":["trace[167597643] 'range keys from in-memory index tree'  (duration: 153.689961ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:26:41.901219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.839355ms","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-09-10T18:26:41.90127Z","caller":"traceutil/trace.go:171","msg":"trace[1213347152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15073; }","duration":"156.937828ms","start":"2026-09-10T18:26:41.744321Z","end":"2026-09-10T18:26:41.901259Z","steps":["trace[1213347152] 'range keys from in-memory index tree'  (duration: 156.677781ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:26:41.901318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.157031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-10T18:26:41.90145Z","caller":"traceutil/trace.go:171","msg":"trace[54485944] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15073; }","duration":"149.366206ms","start":"2026-09-10T18:26:41.752055Z","end":"2026-09-10T18:26:41.901421Z","steps":["trace[54485944] 'range keys from in-memory index tree'  (duration: 148.927054ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:00.506923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.542507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-pvcrh\" ","response":"range_response_count:1 size:12364"}
{"level":"info","ts":"2026-09-10T18:27:00.507037Z","caller":"traceutil/trace.go:171","msg":"trace[1661836481] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-pvcrh; range_end:; response_count:1; response_revision:15187; }","duration":"366.72051ms","start":"2026-09-10T18:27:00.140293Z","end":"2026-09-10T18:27:00.507013Z","steps":["trace[1661836481] 'range keys from in-memory index tree'  (duration: 366.32258ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:00.507038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.510459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"warn","ts":"2026-09-10T18:27:00.507089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:00.140258Z","time spent":"366.818733ms","remote":"127.0.0.1:59158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12388,"request content":"key:\"/registry/pods/openstack/openvswitch-pvcrh\" "}
{"level":"info","ts":"2026-09-10T18:27:00.507096Z","caller":"traceutil/trace.go:171","msg":"trace[464324049] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15187; }","duration":"324.617261ms","start":"2026-09-10T18:27:00.182462Z","end":"2026-09-10T18:27:00.50708Z","steps":["trace[464324049] 'range keys from in-memory index tree'  (duration: 324.303364ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:00.507134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:00.182436Z","time spent":"324.690134ms","remote":"127.0.0.1:59158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-10T18:27:00.507335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.639453ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200306609 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:15161 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:27:00.507476Z","caller":"traceutil/trace.go:171","msg":"trace[2107820352] transaction","detail":"{read_only:false; response_revision:15188; number_of_response:1; }","duration":"163.813996ms","start":"2026-09-10T18:27:00.343633Z","end":"2026-09-10T18:27:00.507447Z","steps":["trace[2107820352] 'process raft request'  (duration: 14.898756ms)","trace[2107820352] 'compare'  (duration: 148.325564ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:27:00.52606Z","caller":"traceutil/trace.go:171","msg":"trace[843969225] transaction","detail":"{read_only:false; response_revision:15189; number_of_response:1; }","duration":"175.61872ms","start":"2026-09-10T18:27:00.350414Z","end":"2026-09-10T18:27:00.526033Z","steps":["trace[843969225] 'process raft request'  (duration: 175.440525ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:26.58018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.472547ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498167200307527 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:15448 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-10T18:27:26.580378Z","caller":"traceutil/trace.go:171","msg":"trace[1457582395] linearizableReadLoop","detail":"{readStateIndex:16050; appliedIndex:16049; }","duration":"380.393823ms","start":"2026-09-10T18:27:26.19996Z","end":"2026-09-10T18:27:26.580354Z","steps":["trace[1457582395] 'read index received'  (duration: 269.521375ms)","trace[1457582395] 'applied index is now lower than readState.Index'  (duration: 110.870278ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:27:26.580477Z","caller":"traceutil/trace.go:171","msg":"trace[1505770195] transaction","detail":"{read_only:false; response_revision:15514; number_of_response:1; }","duration":"381.308688ms","start":"2026-09-10T18:27:26.19912Z","end":"2026-09-10T18:27:26.580429Z","steps":["trace[1505770195] 'process raft request'  (duration: 270.43503ms)","trace[1505770195] 'compare'  (duration: 110.085327ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:27:26.580628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.653151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19606"}
{"level":"warn","ts":"2026-09-10T18:27:26.580707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:26.199087Z","time spent":"381.501033ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:15448 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-10T18:27:26.580803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.6175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-09-10T18:27:26.580855Z","caller":"traceutil/trace.go:171","msg":"trace[1853191732] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:15514; }","duration":"380.685231ms","start":"2026-09-10T18:27:26.200158Z","end":"2026-09-10T18:27:26.580843Z","steps":["trace[1853191732] 'agreement among raft nodes before linearized reading'  (duration: 380.585548ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:26.580903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:26.200151Z","time spent":"380.741122ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"info","ts":"2026-09-10T18:27:26.580689Z","caller":"traceutil/trace.go:171","msg":"trace[1181888441] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:15514; }","duration":"380.729912ms","start":"2026-09-10T18:27:26.199937Z","end":"2026-09-10T18:27:26.580667Z","steps":["trace[1181888441] 'agreement among raft nodes before linearized reading'  (duration: 380.536827ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:26.580977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:26.199926Z","time spent":"381.03991ms","remote":"127.0.0.1:59142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19630,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-09-10T18:27:26.58181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.763405ms","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-09-10T18:27:26.581864Z","caller":"traceutil/trace.go:171","msg":"trace[1431191376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15514; }","duration":"359.845287ms","start":"2026-09-10T18:27:26.222006Z","end":"2026-09-10T18:27:26.581851Z","steps":["trace[1431191376] 'agreement among raft nodes before linearized reading'  (duration: 359.710343ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:26.581902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:26.22199Z","time spent":"359.901329ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-10T18:27:26.582342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.375254ms","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-09-10T18:27:26.582415Z","caller":"traceutil/trace.go:171","msg":"trace[1457471362] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15514; }","duration":"365.499097ms","start":"2026-09-10T18:27:26.216895Z","end":"2026-09-10T18:27:26.582394Z","steps":["trace[1457471362] 'agreement among raft nodes before linearized reading'  (duration: 365.304382ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:27:26.582511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:27:26.216867Z","time spent":"365.627261ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-10T18:27:26.709129Z","caller":"traceutil/trace.go:171","msg":"trace[365705350] transaction","detail":"{read_only:false; response_revision:15518; number_of_response:1; }","duration":"102.809643ms","start":"2026-09-10T18:27:26.606285Z","end":"2026-09-10T18:27:26.709095Z","steps":["trace[365705350] 'process raft request'  (duration: 102.552676ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:30:12.92826Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14538}
{"level":"info","ts":"2026-09-10T18:30:13.033695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14538,"took":"101.795337ms","hash":4189181740,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":30609408,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-10T18:30:13.033787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4189181740,"revision":14538,"compact-revision":12522}
{"level":"info","ts":"2026-09-10T18:32:18.392233Z","caller":"traceutil/trace.go:171","msg":"trace[1119611800] linearizableReadLoop","detail":"{readStateIndex:18511; appliedIndex:18510; }","duration":"138.815851ms","start":"2026-09-10T18:32:18.253386Z","end":"2026-09-10T18:32:18.392202Z","steps":["trace[1119611800] 'read index received'  (duration: 138.665917ms)","trace[1119611800] 'applied index is now lower than readState.Index'  (duration: 148.344µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:32:18.392294Z","caller":"traceutil/trace.go:171","msg":"trace[1134575104] transaction","detail":"{read_only:false; response_revision:17902; number_of_response:1; }","duration":"141.477602ms","start":"2026-09-10T18:32:18.250773Z","end":"2026-09-10T18:32:18.392251Z","steps":["trace[1134575104] 'process raft request'  (duration: 141.198245ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:32:18.392542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.12831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gxz68\" ","response":"range_response_count:1 size:6532"}
{"level":"info","ts":"2026-09-10T18:32:18.392642Z","caller":"traceutil/trace.go:171","msg":"trace[632053744] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gxz68; range_end:; response_count:1; response_revision:17902; }","duration":"139.479329ms","start":"2026-09-10T18:32:18.253146Z","end":"2026-09-10T18:32:18.392625Z","steps":["trace[632053744] 'agreement among raft nodes before linearized reading'  (duration: 139.184861ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:12.935713Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16824}
{"level":"info","ts":"2026-09-10T18:35:13.050437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16824,"took":"110.364384ms","hash":942119729,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":31490048,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-10T18:35:13.050579Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":942119729,"revision":16824,"compact-revision":14538}
{"level":"info","ts":"2026-09-10T18:35:43.43925Z","caller":"traceutil/trace.go:171","msg":"trace[657104003] transaction","detail":"{read_only:false; response_revision:19225; number_of_response:1; }","duration":"300.046448ms","start":"2026-09-10T18:35:43.139179Z","end":"2026-09-10T18:35:43.439226Z","steps":["trace[657104003] 'process raft request'  (duration: 299.886374ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:43.43956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:35:43.139152Z","time spent":"300.305774ms","remote":"127.0.0.1:59158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6748,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/keepalived-gxz68\" mod_revision:19180 > success:<request_put:<key:\"/registry/pods/openstack/keepalived-gxz68\" value_size:6699 >> failure:<request_range:<key:\"/registry/pods/openstack/keepalived-gxz68\" > >"}
{"level":"info","ts":"2026-09-10T18:35:43.440702Z","caller":"traceutil/trace.go:171","msg":"trace[906922499] transaction","detail":"{read_only:false; response_revision:19226; number_of_response:1; }","duration":"138.746409ms","start":"2026-09-10T18:35:43.301933Z","end":"2026-09-10T18:35:43.44068Z","steps":["trace[906922499] 'process raft request'  (duration: 138.384529ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:51.623073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.55881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T18:35:51.623207Z","caller":"traceutil/trace.go:171","msg":"trace[762464914] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:19272; }","duration":"195.760195ms","start":"2026-09-10T18:35:51.427401Z","end":"2026-09-10T18:35:51.623161Z","steps":["trace[762464914] 'count revisions from in-memory index tree'  (duration: 195.451147ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:51.623266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.103877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T18:35:51.623394Z","caller":"traceutil/trace.go:171","msg":"trace[219263236] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:19272; }","duration":"157.289452ms","start":"2026-09-10T18:35:51.466071Z","end":"2026-09-10T18:35:51.623361Z","steps":["trace[219263236] 'count revisions from in-memory index tree'  (duration: 157.017755ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:51.646048Z","caller":"traceutil/trace.go:171","msg":"trace[1619145952] transaction","detail":"{read_only:false; response_revision:19273; number_of_response:1; }","duration":"175.797584ms","start":"2026-09-10T18:35:51.470225Z","end":"2026-09-10T18:35:51.646023Z","steps":["trace[1619145952] 'process raft request'  (duration: 175.539977ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:51.661416Z","caller":"traceutil/trace.go:171","msg":"trace[936517519] transaction","detail":"{read_only:false; response_revision:19274; number_of_response:1; }","duration":"182.050381ms","start":"2026-09-10T18:35:51.47935Z","end":"2026-09-10T18:35:51.6614Z","steps":["trace[936517519] 'process raft request'  (duration: 181.905797ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:52.012868Z","caller":"traceutil/trace.go:171","msg":"trace[859500162] linearizableReadLoop","detail":"{readStateIndex:19934; appliedIndex:19933; }","duration":"342.665961ms","start":"2026-09-10T18:35:51.670143Z","end":"2026-09-10T18:35:52.012809Z","steps":["trace[859500162] 'read index received'  (duration: 247.575353ms)","trace[859500162] 'applied index is now lower than readState.Index'  (duration: 95.088448ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:35:52.01293Z","caller":"traceutil/trace.go:171","msg":"trace[55504445] transaction","detail":"{read_only:false; response_revision:19275; number_of_response:1; }","duration":"353.56843ms","start":"2026-09-10T18:35:51.659316Z","end":"2026-09-10T18:35:52.012884Z","steps":["trace[55504445] 'process raft request'  (duration: 258.443371ms)","trace[55504445] 'compare'  (duration: 94.908414ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:35:52.013097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.942888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-10T18:35:52.013109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:35:51.659281Z","time spent":"353.720544ms","remote":"127.0.0.1:59142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19331,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:18145 > success:<request_put:<key:\"/registry/minions/instance\" value_size:19295 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-09-10T18:35:52.013147Z","caller":"traceutil/trace.go:171","msg":"trace[1534837642] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:19275; }","duration":"343.059092ms","start":"2026-09-10T18:35:51.670071Z","end":"2026-09-10T18:35:52.01313Z","steps":["trace[1534837642] 'agreement among raft nodes before linearized reading'  (duration: 342.956879ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:52.013188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:35:51.670042Z","time spent":"343.133663ms","remote":"127.0.0.1:60898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "}
{"level":"warn","ts":"2026-09-10T18:35:52.013536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.227554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-10T18:35:52.013602Z","caller":"traceutil/trace.go:171","msg":"trace[98408810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19275; }","duration":"241.337887ms","start":"2026-09-10T18:35:51.772245Z","end":"2026-09-10T18:35:52.013583Z","steps":["trace[98408810] 'agreement among raft nodes before linearized reading'  (duration: 241.156932ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:52.013691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.016135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-09-10T18:35:52.013708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.485284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-09-10T18:35:52.01372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.556156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-09-10T18:35:52.013773Z","caller":"traceutil/trace.go:171","msg":"trace[819635160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19275; }","duration":"240.549486ms","start":"2026-09-10T18:35:51.773202Z","end":"2026-09-10T18:35:52.013752Z","steps":["trace[819635160] 'agreement among raft nodes before linearized reading'  (duration: 240.377062ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:52.013859Z","caller":"traceutil/trace.go:171","msg":"trace[817927314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19275; }","duration":"114.7315ms","start":"2026-09-10T18:35:51.899076Z","end":"2026-09-10T18:35:52.013807Z","steps":["trace[817927314] 'agreement among raft nodes before linearized reading'  (duration: 114.35693ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:52.013762Z","caller":"traceutil/trace.go:171","msg":"trace[172405221] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19275; }","duration":"239.105807ms","start":"2026-09-10T18:35:51.774637Z","end":"2026-09-10T18:35:52.013742Z","steps":["trace[172405221] 'agreement among raft nodes before linearized reading'  (duration: 238.923172ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:52.61723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.202707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-10T18:35:52.617318Z","caller":"traceutil/trace.go:171","msg":"trace[915032949] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:19279; }","duration":"416.363251ms","start":"2026-09-10T18:35:52.200935Z","end":"2026-09-10T18:35:52.617298Z","steps":["trace[915032949] 'count revisions from in-memory index tree'  (duration: 416.085673ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:52.617323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.422953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-fbjrf\" ","response":"range_response_count:1 size:22101"}
{"level":"warn","ts":"2026-09-10T18:35:52.617362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:35:52.200903Z","time spent":"416.447043ms","remote":"127.0.0.1:59428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":15,"response size":32,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-09-10T18:35:52.617388Z","caller":"traceutil/trace.go:171","msg":"trace[947115772] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-fbjrf; range_end:; response_count:1; response_revision:19279; }","duration":"199.580927ms","start":"2026-09-10T18:35:52.417785Z","end":"2026-09-10T18:35:52.617366Z","steps":["trace[947115772] 'range keys from in-memory index tree'  (duration: 199.188657ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:52.61776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.937385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-10T18:35:52.617851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.514853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:417608"}
{"level":"info","ts":"2026-09-10T18:35:52.617911Z","caller":"traceutil/trace.go:171","msg":"trace[708453037] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:19279; }","duration":"185.623106ms","start":"2026-09-10T18:35:52.432268Z","end":"2026-09-10T18:35:52.617891Z","steps":["trace[708453037] 'range keys from in-memory index tree'  (duration: 184.774313ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:35:52.617913Z","caller":"traceutil/trace.go:171","msg":"trace[111469729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19279; }","duration":"470.161431ms","start":"2026-09-10T18:35:52.147722Z","end":"2026-09-10T18:35:52.617883Z","steps":["trace[111469729] 'range keys from in-memory index tree'  (duration: 469.827783ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:35:52.617988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:35:52.147698Z","time spent":"470.272685ms","remote":"127.0.0.1:58950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-10T18:35:57.584096Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T18:35:57.590608Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-10T18:35:57.590697Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-10T18:40:12.943331Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19021}
{"level":"info","ts":"2026-09-10T18:40:13.053164Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19021,"took":"105.545236ms","hash":2437901054,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":33656832,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-10T18:40:13.053273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2437901054,"revision":19021,"compact-revision":16824}
{"level":"info","ts":"2026-09-10T18:42:20.632234Z","caller":"traceutil/trace.go:171","msg":"trace[1136758034] transaction","detail":"{read_only:false; response_revision:22195; number_of_response:1; }","duration":"103.473891ms","start":"2026-09-10T18:42:20.528718Z","end":"2026-09-10T18:42:20.632192Z","steps":["trace[1136758034] 'process raft request'  (duration: 103.249225ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:42:20.753271Z","caller":"traceutil/trace.go:171","msg":"trace[1281074333] transaction","detail":"{read_only:false; response_revision:22196; number_of_response:1; }","duration":"121.307195ms","start":"2026-09-10T18:42:20.631918Z","end":"2026-09-10T18:42:20.753225Z","steps":["trace[1281074333] 'process raft request'  (duration: 106.05074ms)","trace[1281074333] 'compare'  (duration: 14.809943ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:42:20.753366Z","caller":"traceutil/trace.go:171","msg":"trace[688601196] linearizableReadLoop","detail":"{readStateIndex:22951; appliedIndex:22950; }","duration":"121.159122ms","start":"2026-09-10T18:42:20.632155Z","end":"2026-09-10T18:42:20.753314Z","steps":["trace[688601196] 'read index received'  (duration: 106.010719ms)","trace[688601196] 'applied index is now lower than readState.Index'  (duration: 15.147293ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:42:20.753733Z","caller":"traceutil/trace.go:171","msg":"trace[2095853179] transaction","detail":"{read_only:false; response_revision:22197; number_of_response:1; }","duration":"115.401908ms","start":"2026-09-10T18:42:20.638262Z","end":"2026-09-10T18:42:20.753664Z","steps":["trace[2095853179] 'process raft request'  (duration: 114.933025ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:42:20.754459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.441819ms","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-09-10T18:42:20.754517Z","caller":"traceutil/trace.go:171","msg":"trace[1383635250] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22198; }","duration":"209.568542ms","start":"2026-09-10T18:42:20.544932Z","end":"2026-09-10T18:42:20.7545Z","steps":["trace[1383635250] 'agreement among raft nodes before linearized reading'  (duration: 208.520264ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:42:20.755035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.890998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-10T18:42:20.755114Z","caller":"traceutil/trace.go:171","msg":"trace[1642773754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22198; }","duration":"208.029581ms","start":"2026-09-10T18:42:20.547065Z","end":"2026-09-10T18:42:20.755094Z","steps":["trace[1642773754] 'agreement among raft nodes before linearized reading'  (duration: 206.410938ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:42:20.961916Z","caller":"traceutil/trace.go:171","msg":"trace[1545259210] linearizableReadLoop","detail":"{readStateIndex:22955; appliedIndex:22953; }","duration":"193.143025ms","start":"2026-09-10T18:42:20.768736Z","end":"2026-09-10T18:42:20.961879Z","steps":["trace[1545259210] 'read index received'  (duration: 80.768598ms)","trace[1545259210] 'applied index is now lower than readState.Index'  (duration: 112.373027ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:42:20.962065Z","caller":"traceutil/trace.go:171","msg":"trace[2050769880] transaction","detail":"{read_only:false; response_revision:22200; number_of_response:1; }","duration":"200.649185ms","start":"2026-09-10T18:42:20.761381Z","end":"2026-09-10T18:42:20.96203Z","steps":["trace[2050769880] 'process raft request'  (duration: 173.871374ms)","trace[2050769880] 'compare'  (duration: 26.419362ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:42:20.962251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.491355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"}
{"level":"info","ts":"2026-09-10T18:42:20.962317Z","caller":"traceutil/trace.go:171","msg":"trace[226381226] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:22200; }","duration":"193.654899ms","start":"2026-09-10T18:42:20.768642Z","end":"2026-09-10T18:42:20.962296Z","steps":["trace[226381226] 'agreement among raft nodes before linearized reading'  (duration: 193.363242ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:42:21.335369Z","caller":"traceutil/trace.go:171","msg":"trace[636112484] transaction","detail":"{read_only:false; response_revision:22201; number_of_response:1; }","duration":"341.989132ms","start":"2026-09-10T18:42:20.993331Z","end":"2026-09-10T18:42:21.335321Z","steps":["trace[636112484] 'process raft request'  (duration: 341.763296ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:42:21.335563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:42:20.993294Z","time spent":"342.163747ms","remote":"127.0.0.1:50348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7680,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" mod_revision:21884 > success:<request_put:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" value_size:7622 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" > >"}
{"level":"info","ts":"2026-09-10T18:42:21.347146Z","caller":"traceutil/trace.go:171","msg":"trace[1253966600] transaction","detail":"{read_only:false; response_revision:22202; number_of_response:1; }","duration":"275.361621ms","start":"2026-09-10T18:42:21.071753Z","end":"2026-09-10T18:42:21.347115Z","steps":["trace[1253966600] 'process raft request'  (duration: 275.169236ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:42:21.350631Z","caller":"traceutil/trace.go:171","msg":"trace[196363242] linearizableReadLoop","detail":"{readStateIndex:22957; appliedIndex:22956; }","duration":"202.776121ms","start":"2026-09-10T18:42:21.147742Z","end":"2026-09-10T18:42:21.350518Z","steps":["trace[196363242] 'read index received'  (duration: 187.573397ms)","trace[196363242] 'applied index is now lower than readState.Index'  (duration: 15.200854ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:42:21.350836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.068249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T18:42:21.350917Z","caller":"traceutil/trace.go:171","msg":"trace[1931182321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22202; }","duration":"203.243964ms","start":"2026-09-10T18:42:21.147652Z","end":"2026-09-10T18:42:21.350896Z","steps":["trace[1931182321] 'agreement among raft nodes before linearized reading'  (duration: 203.061819ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:45:12.951708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21324}
{"level":"info","ts":"2026-09-10T18:45:13.087516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21324,"took":"133.031182ms","hash":627812362,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":29675520,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T18:45:13.087735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":627812362,"revision":21324,"compact-revision":19021}
{"level":"info","ts":"2026-09-10T18:46:40.538852Z","caller":"traceutil/trace.go:171","msg":"trace[978053122] transaction","detail":"{read_only:false; response_revision:24780; number_of_response:1; }","duration":"139.529524ms","start":"2026-09-10T18:46:40.399299Z","end":"2026-09-10T18:46:40.538829Z","steps":["trace[978053122] 'process raft request'  (duration: 139.332839ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:46:40.53903Z","caller":"traceutil/trace.go:171","msg":"trace[1345903545] linearizableReadLoop","detail":"{readStateIndex:25612; appliedIndex:25610; }","duration":"136.736231ms","start":"2026-09-10T18:46:40.402268Z","end":"2026-09-10T18:46:40.539004Z","steps":["trace[1345903545] 'read index received'  (duration: 86.162868ms)","trace[1345903545] 'applied index is now lower than readState.Index'  (duration: 50.570663ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:46:40.539212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.911115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T18:46:40.539292Z","caller":"traceutil/trace.go:171","msg":"trace[547870817] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:24781; }","duration":"137.031129ms","start":"2026-09-10T18:46:40.40224Z","end":"2026-09-10T18:46:40.539271Z","steps":["trace[547870817] 'agreement among raft nodes before linearized reading'  (duration: 136.893915ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:46:40.539237Z","caller":"traceutil/trace.go:171","msg":"trace[1288595275] transaction","detail":"{read_only:false; response_revision:24781; number_of_response:1; }","duration":"128.302956ms","start":"2026-09-10T18:46:40.410835Z","end":"2026-09-10T18:46:40.539138Z","steps":["trace[1288595275] 'process raft request'  (duration: 127.948407ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:46:40.814127Z","caller":"traceutil/trace.go:171","msg":"trace[1413457424] linearizableReadLoop","detail":"{readStateIndex:25614; appliedIndex:25613; }","duration":"275.001641ms","start":"2026-09-10T18:46:40.53909Z","end":"2026-09-10T18:46:40.814092Z","steps":["trace[1413457424] 'read index received'  (duration: 258.807731ms)","trace[1413457424] 'applied index is now lower than readState.Index'  (duration: 16.19239ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T18:46:40.81431Z","caller":"traceutil/trace.go:171","msg":"trace[1579293999] transaction","detail":"{read_only:false; response_revision:24782; number_of_response:1; }","duration":"281.378861ms","start":"2026-09-10T18:46:40.532861Z","end":"2026-09-10T18:46:40.81424Z","steps":["trace[1579293999] 'process raft request'  (duration: 264.972335ms)","trace[1579293999] 'compare'  (duration: 15.994645ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T18:46:40.815751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.658027ms","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-09-10T18:46:40.815947Z","caller":"traceutil/trace.go:171","msg":"trace[1132393946] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24782; }","duration":"310.922574ms","start":"2026-09-10T18:46:40.504993Z","end":"2026-09-10T18:46:40.815915Z","steps":["trace[1132393946] 'agreement among raft nodes before linearized reading'  (duration: 309.26414ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:46:40.81613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T18:46:40.50496Z","time spent":"311.14914ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-10T18:46:40.870757Z","caller":"traceutil/trace.go:171","msg":"trace[812777227] transaction","detail":"{read_only:false; response_revision:24783; number_of_response:1; }","duration":"147.814045ms","start":"2026-09-10T18:46:40.722888Z","end":"2026-09-10T18:46:40.870702Z","steps":["trace[812777227] 'process raft request'  (duration: 147.525267ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T18:46:40.871128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.539002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-09-10T18:46:40.871258Z","caller":"traceutil/trace.go:171","msg":"trace[1684707003] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:24784; }","duration":"137.759657ms","start":"2026-09-10T18:46:40.733471Z","end":"2026-09-10T18:46:40.871231Z","steps":["trace[1684707003] 'agreement among raft nodes before linearized reading'  (duration: 137.302945ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:47:52.694931Z","caller":"traceutil/trace.go:171","msg":"trace[1262803094] transaction","detail":"{read_only:false; response_revision:25592; number_of_response:1; }","duration":"103.625072ms","start":"2026-09-10T18:47:52.59127Z","end":"2026-09-10T18:47:52.694896Z","steps":["trace[1262803094] 'process raft request'  (duration: 103.394976ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T18:49:42.850159Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006aab.wal"}
{"level":"info","ts":"2026-09-10T18:50:12.961993Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23537}
{"level":"info","ts":"2026-09-10T18:50:13.096546Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23537,"took":"128.561393ms","hash":718489096,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":42557440,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-09-10T18:50:13.096649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":718489096,"revision":23537,"compact-revision":21324}
{"level":"info","ts":"2026-09-10T18:55:12.973752Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26683}
{"level":"info","ts":"2026-09-10T18:55:13.118222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26683,"took":"139.840792ms","hash":2858631460,"current-db-size-bytes":55721984,"current-db-size":"56 MB","current-db-size-in-use-bytes":29945856,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T18:55:13.11829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2858631460,"revision":26683,"compact-revision":23537}
{"level":"info","ts":"2026-09-10T18:55:31.260129Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab61124f07c17f20","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T18:55:31.266235Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-10T18:55:31.266329Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}