{"level":"warn","ts":"2026-10-26T21:26:49.289601Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T21:26:49.289719Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.22:2380","--initial-cluster=instance=https://162.253.55.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.22:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-26T21:26:49.2898Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T21:26:49.289817Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.22:2380"]}
{"level":"info","ts":"2026-10-26T21:26:49.289846Z","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-10-26T21:26:49.290667Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"]}
{"level":"info","ts":"2026-10-26T21:26:49.29077Z","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.22:2380"],"listen-peer-urls":["https://162.253.55.22:2380"],"advertise-client-urls":["https://162.253.55.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.22:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-26T21:26:49.294282Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.241954ms"}
{"level":"info","ts":"2026-10-26T21:26:49.301866Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8608f4af3693a53b","cluster-id":"c541111188849f0e"}
{"level":"info","ts":"2026-10-26T21:26:49.30197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=()"}
{"level":"info","ts":"2026-10-26T21:26:49.301999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became follower at term 0"}
{"level":"info","ts":"2026-10-26T21:26:49.302017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8608f4af3693a53b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-26T21:26:49.30203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became follower at term 1"}
{"level":"info","ts":"2026-10-26T21:26:49.30208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=(9658238434268128571)"}
{"level":"warn","ts":"2026-10-26T21:26:49.309244Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-26T21:26:49.311011Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-26T21:26:49.313334Z","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-10-26T21:26:49.315537Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8608f4af3693a53b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-26T21:26:49.315965Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8608f4af3693a53b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-26T21:26:49.31604Z","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-10-26T21:26:49.316182Z","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-10-26T21:26:49.316212Z","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-10-26T21:26:49.318277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=(9658238434268128571)"}
{"level":"info","ts":"2026-10-26T21:26:49.318473Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c541111188849f0e","local-member-id":"8608f4af3693a53b","added-peer-id":"8608f4af3693a53b","added-peer-peer-urls":["https://162.253.55.22:2380"]}
{"level":"info","ts":"2026-10-26T21:26:49.320202Z","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-10-26T21:26:49.320343Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.22:2380"}
{"level":"info","ts":"2026-10-26T21:26:49.320386Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.22:2380"}
{"level":"info","ts":"2026-10-26T21:26:49.320508Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8608f4af3693a53b","initial-advertise-peer-urls":["https://162.253.55.22:2380"],"listen-peer-urls":["https://162.253.55.22:2380"],"advertise-client-urls":["https://162.253.55.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-26T21:26:49.320573Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-26T21:26:49.9026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b is starting a new election at term 1"}
{"level":"info","ts":"2026-10-26T21:26:49.902684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-26T21:26:49.902708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b received MsgPreVoteResp from 8608f4af3693a53b at term 1"}
{"level":"info","ts":"2026-10-26T21:26:49.902781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became candidate at term 2"}
{"level":"info","ts":"2026-10-26T21:26:49.902793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b received MsgVoteResp from 8608f4af3693a53b at term 2"}
{"level":"info","ts":"2026-10-26T21:26:49.902841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became leader at term 2"}
{"level":"info","ts":"2026-10-26T21:26:49.902861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8608f4af3693a53b elected leader 8608f4af3693a53b at term 2"}
{"level":"info","ts":"2026-10-26T21:26:49.904482Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T21:26:49.905388Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8608f4af3693a53b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.22:2379]}","request-path":"/0/members/8608f4af3693a53b/attributes","cluster-id":"c541111188849f0e","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-26T21:26:49.905594Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T21:26:49.905645Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T21:26:49.906107Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c541111188849f0e","local-member-id":"8608f4af3693a53b","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T21:26:49.906315Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T21:26:49.906389Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T21:26:49.908419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.22:2379"}
{"level":"info","ts":"2026-10-26T21:26:49.909238Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-26T21:26:49.909283Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-26T21:26:49.909581Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-26T21:27:06.205991Z","caller":"traceutil/trace.go:171","msg":"trace[1341026755] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"241.588742ms","start":"2026-10-26T21:27:05.964371Z","end":"2026-10-26T21:27:06.20596Z","steps":["trace[1341026755] 'process raft request'  (duration: 241.433228ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:27:06.414426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.704206ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:27:06.414716Z","caller":"traceutil/trace.go:171","msg":"trace[9014192] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:374; }","duration":"113.020804ms","start":"2026-10-26T21:27:06.301664Z","end":"2026-10-26T21:27:06.414685Z","steps":["trace[9014192] 'range keys from in-memory index tree'  (duration: 112.675335ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:27:44.212837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.86193ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11906287585709710148 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-10-26T21:27:44.213167Z","caller":"traceutil/trace.go:171","msg":"trace[1757909274] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"181.003012ms","start":"2026-10-26T21:27:44.032014Z","end":"2026-10-26T21:27:44.213017Z","steps":["trace[1757909274] 'process raft request'  (duration: 44.92035ms)","trace[1757909274] 'compare'  (duration: 134.745606ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:27:44.622468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.000681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:27:44.622583Z","caller":"traceutil/trace.go:171","msg":"trace[1239402760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"190.176515ms","start":"2026-10-26T21:27:44.432387Z","end":"2026-10-26T21:27:44.622563Z","steps":["trace[1239402760] 'range keys from in-memory index tree'  (duration: 189.831316ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:27:45.148176Z","caller":"traceutil/trace.go:171","msg":"trace[1343691249] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"330.234572ms","start":"2026-10-26T21:27:44.817914Z","end":"2026-10-26T21:27:45.148148Z","steps":["trace[1343691249] 'read index received'  (duration: 287.156792ms)","trace[1343691249] 'applied index is now lower than readState.Index'  (duration: 43.07679ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:27:45.148305Z","caller":"traceutil/trace.go:171","msg":"trace[265836260] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"448.00783ms","start":"2026-10-26T21:27:44.700259Z","end":"2026-10-26T21:27:45.148267Z","steps":["trace[265836260] 'process raft request'  (duration: 404.814847ms)","trace[265836260] 'compare'  (duration: 42.66188ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:27:45.148393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.468889ms","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-10-26T21:27:45.148459Z","caller":"traceutil/trace.go:171","msg":"trace[1406916784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"330.589712ms","start":"2026-10-26T21:27:44.817857Z","end":"2026-10-26T21:27:45.148446Z","steps":["trace[1406916784] 'agreement among raft nodes before linearized reading'  (duration: 330.400917ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:27:45.148499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:27:44.817834Z","time spent":"330.656543ms","remote":"127.0.0.1:44280","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":"warn","ts":"2026-10-26T21:27:45.148784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:27:44.700222Z","time spent":"448.183315ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-k5qm4\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-k5qm4\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-k5qm4\" > >"}
{"level":"info","ts":"2026-10-26T21:27:45.14858Z","caller":"traceutil/trace.go:171","msg":"trace[1123048010] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"413.781953ms","start":"2026-10-26T21:27:44.734597Z","end":"2026-10-26T21:27:45.148379Z","steps":["trace[1123048010] 'process raft request'  (duration: 413.470855ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:27:45.149008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:27:44.734571Z","time spent":"414.38574ms","remote":"127.0.0.1:52892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-10-26T21:29:21.940647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.385534ms","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-10-26T21:29:21.941025Z","caller":"traceutil/trace.go:171","msg":"trace[1599108953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1868; }","duration":"110.810216ms","start":"2026-10-26T21:29:21.830189Z","end":"2026-10-26T21:29:21.940999Z","steps":["trace[1599108953] 'range keys from in-memory index tree'  (duration: 110.176428ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:29:22.351632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.195685ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11906287585709712658 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1758 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T21:29:22.351771Z","caller":"traceutil/trace.go:171","msg":"trace[926570367] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"150.143759ms","start":"2026-10-26T21:29:22.201586Z","end":"2026-10-26T21:29:22.351729Z","steps":["trace[926570367] 'read index received'  (duration: 38.001µs)","trace[926570367] 'applied index is now lower than readState.Index'  (duration: 150.104428ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:29:22.351855Z","caller":"traceutil/trace.go:171","msg":"trace[1130448836] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"319.477898ms","start":"2026-10-26T21:29:22.032346Z","end":"2026-10-26T21:29:22.351824Z","steps":["trace[1130448836] 'process raft request'  (duration: 28.981935ms)","trace[1130448836] 'compare'  (duration: 289.900006ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:29:22.351979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.393845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-26T21:29:22.352023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:22.032322Z","time spent":"319.60738ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1758 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-10-26T21:29:22.352051Z","caller":"traceutil/trace.go:171","msg":"trace[1173014912] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1870; }","duration":"150.529019ms","start":"2026-10-26T21:29:22.201509Z","end":"2026-10-26T21:29:22.352038Z","steps":["trace[1173014912] 'agreement among raft nodes before linearized reading'  (duration: 150.381325ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:29:22.352103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.114589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"}
{"level":"info","ts":"2026-10-26T21:29:22.352185Z","caller":"traceutil/trace.go:171","msg":"trace[1972827460] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1870; }","duration":"137.224392ms","start":"2026-10-26T21:29:22.21494Z","end":"2026-10-26T21:29:22.352164Z","steps":["trace[1972827460] 'agreement among raft nodes before linearized reading'  (duration: 137.019397ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:29:22.352325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.677254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-97a26bff-4c2c-4628-b364-5657c1b32817\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-10-26T21:29:22.352385Z","caller":"traceutil/trace.go:171","msg":"trace[569933712] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-97a26bff-4c2c-4628-b364-5657c1b32817; range_end:; response_count:1; response_revision:1870; }","duration":"107.779417ms","start":"2026-10-26T21:29:22.244589Z","end":"2026-10-26T21:29:22.352368Z","steps":["trace[569933712] 'agreement among raft nodes before linearized reading'  (duration: 107.596292ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:30:12.954761Z","caller":"traceutil/trace.go:171","msg":"trace[1479643938] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"120.322542ms","start":"2026-10-26T21:30:12.834381Z","end":"2026-10-26T21:30:12.954704Z","steps":["trace[1479643938] 'process raft request'  (duration: 120.098546ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:30:13.098872Z","caller":"traceutil/trace.go:171","msg":"trace[1453013451] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"139.717857ms","start":"2026-10-26T21:30:12.959095Z","end":"2026-10-26T21:30:13.098813Z","steps":["trace[1453013451] 'process raft request'  (duration: 137.992172ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:30:13.099376Z","caller":"traceutil/trace.go:171","msg":"trace[314662232] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"139.865251ms","start":"2026-10-26T21:30:12.959219Z","end":"2026-10-26T21:30:13.099085Z","steps":["trace[314662232] 'process raft request'  (duration: 139.548253ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:30:18.42312Z","caller":"traceutil/trace.go:171","msg":"trace[4144978] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"109.563693ms","start":"2026-10-26T21:30:18.313515Z","end":"2026-10-26T21:30:18.423078Z","steps":["trace[4144978] 'process raft request'  (duration: 109.277175ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:31:09.731261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.593249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T21:31:09.73136Z","caller":"traceutil/trace.go:171","msg":"trace[792319305] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2671; }","duration":"148.763915ms","start":"2026-10-26T21:31:09.582571Z","end":"2026-10-26T21:31:09.731335Z","steps":["trace[792319305] 'count revisions from in-memory index tree'  (duration: 148.477566ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:31:42.391269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.744735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-10-26T21:31:42.39134Z","caller":"traceutil/trace.go:171","msg":"trace[1510527340] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2870; }","duration":"130.879168ms","start":"2026-10-26T21:31:42.260447Z","end":"2026-10-26T21:31:42.391326Z","steps":["trace[1510527340] 'range keys from in-memory index tree'  (duration: 130.55817ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:34:58.925173Z","caller":"traceutil/trace.go:171","msg":"trace[157894334] transaction","detail":"{read_only:false; response_revision:4107; number_of_response:1; }","duration":"125.703438ms","start":"2026-10-26T21:34:58.799441Z","end":"2026-10-26T21:34:58.925144Z","steps":["trace[157894334] 'process raft request'  (duration: 68.771514ms)","trace[157894334] 'compare'  (duration: 56.737939ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:36:36.727598Z","caller":"traceutil/trace.go:171","msg":"trace[751966418] linearizableReadLoop","detail":"{readStateIndex:5429; appliedIndex:5428; }","duration":"112.121563ms","start":"2026-10-26T21:36:36.615443Z","end":"2026-10-26T21:36:36.727565Z","steps":["trace[751966418] 'read index received'  (duration: 111.98229ms)","trace[751966418] 'applied index is now lower than readState.Index'  (duration: 137.603µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:36:36.728133Z","caller":"traceutil/trace.go:171","msg":"trace[124627139] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"140.438412ms","start":"2026-10-26T21:36:36.587646Z","end":"2026-10-26T21:36:36.728085Z","steps":["trace[124627139] 'process raft request'  (duration: 139.669372ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:36.728225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.76202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vs9k7\" ","response":"range_response_count:1 size:9753"}
{"level":"info","ts":"2026-10-26T21:36:36.728282Z","caller":"traceutil/trace.go:171","msg":"trace[1673908742] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vs9k7; range_end:; response_count:1; response_revision:5226; }","duration":"112.916394ms","start":"2026-10-26T21:36:36.615349Z","end":"2026-10-26T21:36:36.728265Z","steps":["trace[1673908742] 'agreement among raft nodes before linearized reading'  (duration: 112.702379ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:36.729708Z","caller":"traceutil/trace.go:171","msg":"trace[1764268411] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"110.862879ms","start":"2026-10-26T21:36:36.618816Z","end":"2026-10-26T21:36:36.729678Z","steps":["trace[1764268411] 'process raft request'  (duration: 110.261844ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:42.382892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.456244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T21:36:42.382932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.349859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"}
{"level":"info","ts":"2026-10-26T21:36:42.382997Z","caller":"traceutil/trace.go:171","msg":"trace[1714920649] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5367; }","duration":"152.66036ms","start":"2026-10-26T21:36:42.230316Z","end":"2026-10-26T21:36:42.382977Z","steps":["trace[1714920649] 'range keys from in-memory index tree'  (duration: 152.348252ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:42.38294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.213567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74ef55b7-dbaa-4f02-a322-e3292e96efea\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-10-26T21:36:42.383087Z","caller":"traceutil/trace.go:171","msg":"trace[619532298] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-74ef55b7-dbaa-4f02-a322-e3292e96efea; range_end:; response_count:1; response_revision:5367; }","duration":"119.411393ms","start":"2026-10-26T21:36:42.26364Z","end":"2026-10-26T21:36:42.383051Z","steps":["trace[619532298] 'range keys from in-memory index tree'  (duration: 118.977172ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:42.383011Z","caller":"traceutil/trace.go:171","msg":"trace[1859787028] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5367; }","duration":"145.500354ms","start":"2026-10-26T21:36:42.237495Z","end":"2026-10-26T21:36:42.382996Z","steps":["trace[1859787028] 'range keys from in-memory index tree'  (duration: 145.165715ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:42.585742Z","caller":"traceutil/trace.go:171","msg":"trace[2137921140] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5368; }","duration":"158.702218ms","start":"2026-10-26T21:36:42.427012Z","end":"2026-10-26T21:36:42.585714Z","steps":["trace[2137921140] 'process raft request'  (duration: 126.457657ms)","trace[2137921140] 'compare'  (duration: 31.85902ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:36:42.586249Z","caller":"traceutil/trace.go:171","msg":"trace[683814388] linearizableReadLoop","detail":"{readStateIndex:5576; appliedIndex:5575; }","duration":"151.636113ms","start":"2026-10-26T21:36:42.433927Z","end":"2026-10-26T21:36:42.585563Z","steps":["trace[683814388] 'read index received'  (duration: 119.558837ms)","trace[683814388] 'applied index is now lower than readState.Index'  (duration: 32.075896ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:36:42.586392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.418884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:36:42.586445Z","caller":"traceutil/trace.go:171","msg":"trace[429014046] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5369; }","duration":"152.562308ms","start":"2026-10-26T21:36:42.43387Z","end":"2026-10-26T21:36:42.586432Z","steps":["trace[429014046] 'agreement among raft nodes before linearized reading'  (duration: 152.425504ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:42.586408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.83282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:36:42.587604Z","caller":"traceutil/trace.go:171","msg":"trace[969077918] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5369; }","duration":"122.119173ms","start":"2026-10-26T21:36:42.465467Z","end":"2026-10-26T21:36:42.587586Z","steps":["trace[969077918] 'agreement among raft nodes before linearized reading'  (duration: 120.873901ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:42.886815Z","caller":"traceutil/trace.go:171","msg":"trace[336494284] linearizableReadLoop","detail":"{readStateIndex:5584; appliedIndex:5581; }","duration":"128.440499ms","start":"2026-10-26T21:36:42.758335Z","end":"2026-10-26T21:36:42.886776Z","steps":["trace[336494284] 'read index received'  (duration: 11.277544ms)","trace[336494284] 'applied index is now lower than readState.Index'  (duration: 117.161624ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:36:42.886928Z","caller":"traceutil/trace.go:171","msg":"trace[1383635066] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"158.244195ms","start":"2026-10-26T21:36:42.72864Z","end":"2026-10-26T21:36:42.886884Z","steps":["trace[1383635066] 'process raft request'  (duration: 157.806154ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:42.88699Z","caller":"traceutil/trace.go:171","msg":"trace[2124853543] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"154.743844ms","start":"2026-10-26T21:36:42.732205Z","end":"2026-10-26T21:36:42.886949Z","steps":["trace[2124853543] 'process raft request'  (duration: 154.481427ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:42.887173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.800978ms","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-10-26T21:36:42.887218Z","caller":"traceutil/trace.go:171","msg":"trace[149649816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5376; }","duration":"128.903951ms","start":"2026-10-26T21:36:42.7583Z","end":"2026-10-26T21:36:42.887204Z","steps":["trace[149649816] 'agreement among raft nodes before linearized reading'  (duration: 128.681565ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:42.902785Z","caller":"traceutil/trace.go:171","msg":"trace[981535332] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"129.502557ms","start":"2026-10-26T21:36:42.773259Z","end":"2026-10-26T21:36:42.902762Z","steps":["trace[981535332] 'process raft request'  (duration: 129.342653ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:42.902908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.246591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-krfl9\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-26T21:36:42.902989Z","caller":"traceutil/trace.go:171","msg":"trace[482526291] range","detail":"{range_begin:/registry/pods/openstack/keepalived-krfl9; range_end:; response_count:1; response_revision:5377; }","duration":"139.360864ms","start":"2026-10-26T21:36:42.763608Z","end":"2026-10-26T21:36:42.902969Z","steps":["trace[482526291] 'agreement among raft nodes before linearized reading'  (duration: 139.125448ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:43.116471Z","caller":"traceutil/trace.go:171","msg":"trace[1331718596] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"164.003436ms","start":"2026-10-26T21:36:42.952438Z","end":"2026-10-26T21:36:43.116441Z","steps":["trace[1331718596] 'process raft request'  (duration: 163.949775ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:43.116526Z","caller":"traceutil/trace.go:171","msg":"trace[978191901] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"165.666059ms","start":"2026-10-26T21:36:42.950824Z","end":"2026-10-26T21:36:43.11649Z","steps":["trace[978191901] 'process raft request'  (duration: 165.356721ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:50.001323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2911}
{"level":"info","ts":"2026-10-26T21:36:50.083522Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2911,"took":"80.334405ms","hash":1881363276,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":30593024,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T21:36:50.083612Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1881363276,"revision":2911,"compact-revision":-1}
{"level":"info","ts":"2026-10-26T21:36:58.354029Z","caller":"traceutil/trace.go:171","msg":"trace[1921790086] linearizableReadLoop","detail":"{readStateIndex:5894; appliedIndex:5893; }","duration":"400.499152ms","start":"2026-10-26T21:36:57.953494Z","end":"2026-10-26T21:36:58.353993Z","steps":["trace[1921790086] 'read index received'  (duration: 400.160853ms)","trace[1921790086] 'applied index is now lower than readState.Index'  (duration: 336.859µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:36:58.354194Z","caller":"traceutil/trace.go:171","msg":"trace[1013596636] transaction","detail":"{read_only:false; response_revision:5675; number_of_response:1; }","duration":"430.048612ms","start":"2026-10-26T21:36:57.92413Z","end":"2026-10-26T21:36:58.354179Z","steps":["trace[1013596636] 'process raft request'  (duration: 429.643451ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:58.354408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:36:57.924111Z","time spent":"430.113823ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8334,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-86cf4f7cb6-sj9lp\" mod_revision:5657 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-86cf4f7cb6-sj9lp\" value_size:8265 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-86cf4f7cb6-sj9lp\" > >"}
{"level":"warn","ts":"2026-10-26T21:36:58.354524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.013104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:36:58.354644Z","caller":"traceutil/trace.go:171","msg":"trace[845584940] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5675; }","duration":"401.20012ms","start":"2026-10-26T21:36:57.95341Z","end":"2026-10-26T21:36:58.354611Z","steps":["trace[845584940] 'agreement among raft nodes before linearized reading'  (duration: 401.034365ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:58.354708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:36:57.953358Z","time spent":"401.336834ms","remote":"127.0.0.1:52822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-10-26T21:36:58.354735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.51504ms","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-10-26T21:36:58.354848Z","caller":"traceutil/trace.go:171","msg":"trace[1213742977] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5675; }","duration":"197.702185ms","start":"2026-10-26T21:36:58.15712Z","end":"2026-10-26T21:36:58.354822Z","steps":["trace[1213742977] 'agreement among raft nodes before linearized reading'  (duration: 197.365065ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:58.354946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.322856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T21:36:58.355076Z","caller":"traceutil/trace.go:171","msg":"trace[1932745411] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5675; }","duration":"240.415388ms","start":"2026-10-26T21:36:58.114596Z","end":"2026-10-26T21:36:58.355011Z","steps":["trace[1932745411] 'agreement among raft nodes before linearized reading'  (duration: 239.77371ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:58.611859Z","caller":"traceutil/trace.go:171","msg":"trace[208286921] transaction","detail":"{read_only:false; response_revision:5677; number_of_response:1; }","duration":"250.405778ms","start":"2026-10-26T21:36:58.361418Z","end":"2026-10-26T21:36:58.611824Z","steps":["trace[208286921] 'process raft request'  (duration: 250.134721ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:58.61226Z","caller":"traceutil/trace.go:171","msg":"trace[1365360846] transaction","detail":"{read_only:false; response_revision:5678; number_of_response:1; }","duration":"250.592413ms","start":"2026-10-26T21:36:58.361625Z","end":"2026-10-26T21:36:58.612217Z","steps":["trace[1365360846] 'process raft request'  (duration: 250.148091ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:58.612352Z","caller":"traceutil/trace.go:171","msg":"trace[1118997709] linearizableReadLoop","detail":"{readStateIndex:5899; appliedIndex:5894; }","duration":"248.333233ms","start":"2026-10-26T21:36:58.363984Z","end":"2026-10-26T21:36:58.612317Z","steps":["trace[1118997709] 'read index received'  (duration: 24.284272ms)","trace[1118997709] 'applied index is now lower than readState.Index'  (duration: 224.047301ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:36:58.61244Z","caller":"traceutil/trace.go:171","msg":"trace[31582910] transaction","detail":"{read_only:false; response_revision:5679; number_of_response:1; }","duration":"249.369552ms","start":"2026-10-26T21:36:58.363046Z","end":"2026-10-26T21:36:58.612415Z","steps":["trace[31582910] 'process raft request'  (duration: 249.010702ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:36:58.61252Z","caller":"traceutil/trace.go:171","msg":"trace[483680309] transaction","detail":"{read_only:false; response_revision:5680; number_of_response:1; }","duration":"249.241958ms","start":"2026-10-26T21:36:58.363261Z","end":"2026-10-26T21:36:58.612503Z","steps":["trace[483680309] 'process raft request'  (duration: 248.944069ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:58.612675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.675244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"}
{"level":"info","ts":"2026-10-26T21:36:58.612719Z","caller":"traceutil/trace.go:171","msg":"trace[1538997691] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5680; }","duration":"248.772636ms","start":"2026-10-26T21:36:58.363934Z","end":"2026-10-26T21:36:58.612706Z","steps":["trace[1538997691] 'agreement among raft nodes before linearized reading'  (duration: 248.577481ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:58.613135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.244029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-26T21:36:58.613216Z","caller":"traceutil/trace.go:171","msg":"trace[35155328] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5680; }","duration":"124.391814ms","start":"2026-10-26T21:36:58.488804Z","end":"2026-10-26T21:36:58.613196Z","steps":["trace[35155328] 'agreement among raft nodes before linearized reading'  (duration: 124.174568ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:36:58.61262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.245913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:36:58.614199Z","caller":"traceutil/trace.go:171","msg":"trace[1352246395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5680; }","duration":"180.864984ms","start":"2026-10-26T21:36:58.433288Z","end":"2026-10-26T21:36:58.614153Z","steps":["trace[1352246395] 'agreement among raft nodes before linearized reading'  (duration: 179.255073ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:41:50.008724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5529}
{"level":"info","ts":"2026-10-26T21:41:50.108873Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5529,"took":"97.820036ms","hash":2440773938,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":28557312,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-26T21:41:50.108956Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2440773938,"revision":5529,"compact-revision":2911}
{"level":"info","ts":"2026-10-26T21:43:21.744615Z","caller":"traceutil/trace.go:171","msg":"trace[225278139] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"266.191939ms","start":"2026-10-26T21:43:21.478384Z","end":"2026-10-26T21:43:21.744576Z","steps":["trace[225278139] 'process raft request'  (duration: 265.931012ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:43:33.437475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.856053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:43:33.437698Z","caller":"traceutil/trace.go:171","msg":"trace[1351425986] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8742; }","duration":"151.111869ms","start":"2026-10-26T21:43:33.286533Z","end":"2026-10-26T21:43:33.437645Z","steps":["trace[1351425986] 'count revisions from in-memory index tree'  (duration: 150.788501ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:43:33.437757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.380416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:43:33.437851Z","caller":"traceutil/trace.go:171","msg":"trace[1919589511] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8742; }","duration":"151.51583ms","start":"2026-10-26T21:43:33.286306Z","end":"2026-10-26T21:43:33.437822Z","steps":["trace[1919589511] 'range keys from in-memory index tree'  (duration: 151.16036ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:43:33.43773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.242973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:43:33.438025Z","caller":"traceutil/trace.go:171","msg":"trace[837215120] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8742; }","duration":"151.572981ms","start":"2026-10-26T21:43:33.286436Z","end":"2026-10-26T21:43:33.438009Z","steps":["trace[837215120] 'range keys from in-memory index tree'  (duration: 151.165911ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:43:33.541121Z","caller":"traceutil/trace.go:171","msg":"trace[1469843234] transaction","detail":"{read_only:false; response_revision:8743; number_of_response:1; }","duration":"142.507016ms","start":"2026-10-26T21:43:33.398565Z","end":"2026-10-26T21:43:33.541072Z","steps":["trace[1469843234] 'process raft request'  (duration: 142.2628ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:43:33.595568Z","caller":"traceutil/trace.go:171","msg":"trace[1397026530] linearizableReadLoop","detail":"{readStateIndex:9056; appliedIndex:9054; }","duration":"162.453735ms","start":"2026-10-26T21:43:33.433079Z","end":"2026-10-26T21:43:33.595533Z","steps":["trace[1397026530] 'read index received'  (duration: 107.783484ms)","trace[1397026530] 'applied index is now lower than readState.Index'  (duration: 54.669091ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:43:33.595731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.635059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:43:33.595719Z","caller":"traceutil/trace.go:171","msg":"trace[1965589609] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"190.75445ms","start":"2026-10-26T21:43:33.404898Z","end":"2026-10-26T21:43:33.595652Z","steps":["trace[1965589609] 'process raft request'  (duration: 190.487663ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:43:33.595757Z","caller":"traceutil/trace.go:171","msg":"trace[346706100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8744; }","duration":"162.712241ms","start":"2026-10-26T21:43:33.433036Z","end":"2026-10-26T21:43:33.595748Z","steps":["trace[346706100] 'agreement among raft nodes before linearized reading'  (duration: 162.622949ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:43:33.595962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.4558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"}
{"level":"info","ts":"2026-10-26T21:43:33.596021Z","caller":"traceutil/trace.go:171","msg":"trace[1977685082] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8744; }","duration":"153.552632ms","start":"2026-10-26T21:43:33.442455Z","end":"2026-10-26T21:43:33.596008Z","steps":["trace[1977685082] 'agreement among raft nodes before linearized reading'  (duration: 153.333586ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:05.049217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.781552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:44:05.049365Z","caller":"traceutil/trace.go:171","msg":"trace[24915539] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8965; }","duration":"455.990997ms","start":"2026-10-26T21:44:04.593343Z","end":"2026-10-26T21:44:05.049334Z","steps":["trace[24915539] 'range keys from in-memory index tree'  (duration: 455.685729ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:05.049427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:44:04.593319Z","time spent":"456.09371ms","remote":"127.0.0.1:52822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-10-26T21:44:05.04958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.395758ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11906287585709730880 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8860 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T21:44:05.049757Z","caller":"traceutil/trace.go:171","msg":"trace[966850911] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9286; }","duration":"121.51032ms","start":"2026-10-26T21:44:04.928224Z","end":"2026-10-26T21:44:05.049734Z","steps":["trace[966850911] 'read index received'  (duration: 82.852µs)","trace[966850911] 'applied index is now lower than readState.Index'  (duration: 121.425698ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:44:05.049803Z","caller":"traceutil/trace.go:171","msg":"trace[1476210972] transaction","detail":"{read_only:false; response_revision:8966; number_of_response:1; }","duration":"439.923269ms","start":"2026-10-26T21:44:04.609837Z","end":"2026-10-26T21:44:05.04976Z","steps":["trace[1476210972] 'process raft request'  (duration: 306.180502ms)","trace[1476210972] 'compare'  (duration: 133.153782ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:44:05.049854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.632862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T21:44:05.050033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:44:04.609806Z","time spent":"440.100884ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8860 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-10-26T21:44:05.050036Z","caller":"traceutil/trace.go:171","msg":"trace[1464814311] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8966; }","duration":"121.798287ms","start":"2026-10-26T21:44:04.928204Z","end":"2026-10-26T21:44:05.050002Z","steps":["trace[1464814311] 'agreement among raft nodes before linearized reading'  (duration: 121.597291ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:14.730865Z","caller":"traceutil/trace.go:171","msg":"trace[517832473] transaction","detail":"{read_only:false; response_revision:9019; number_of_response:1; }","duration":"141.797737ms","start":"2026-10-26T21:44:14.589038Z","end":"2026-10-26T21:44:14.730835Z","steps":["trace[517832473] 'process raft request'  (duration: 141.591551ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:15.507778Z","caller":"traceutil/trace.go:171","msg":"trace[1175719634] linearizableReadLoop","detail":"{readStateIndex:9345; appliedIndex:9344; }","duration":"114.754345ms","start":"2026-10-26T21:44:15.392977Z","end":"2026-10-26T21:44:15.507731Z","steps":["trace[1175719634] 'read index received'  (duration: 69.882137ms)","trace[1175719634] 'applied index is now lower than readState.Index'  (duration: 44.870178ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:44:15.50791Z","caller":"traceutil/trace.go:171","msg":"trace[1758508129] transaction","detail":"{read_only:false; response_revision:9022; number_of_response:1; }","duration":"125.841463ms","start":"2026-10-26T21:44:15.382025Z","end":"2026-10-26T21:44:15.507866Z","steps":["trace[1758508129] 'process raft request'  (duration: 80.816352ms)","trace[1758508129] 'compare'  (duration: 44.688762ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T21:44:15.508137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.117244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:6011"}
{"level":"info","ts":"2026-10-26T21:44:15.508257Z","caller":"traceutil/trace.go:171","msg":"trace[1072348812] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:9022; }","duration":"115.263618ms","start":"2026-10-26T21:44:15.392935Z","end":"2026-10-26T21:44:15.508199Z","steps":["trace[1072348812] 'agreement among raft nodes before linearized reading'  (duration: 115.001001ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.253086Z","caller":"traceutil/trace.go:171","msg":"trace[1717285312] linearizableReadLoop","detail":"{readStateIndex:9370; appliedIndex:9367; }","duration":"154.187199ms","start":"2026-10-26T21:44:18.098868Z","end":"2026-10-26T21:44:18.253055Z","steps":["trace[1717285312] 'read index received'  (duration: 47.815173ms)","trace[1717285312] 'applied index is now lower than readState.Index'  (duration: 106.370306ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:44:18.253496Z","caller":"traceutil/trace.go:171","msg":"trace[1746523478] transaction","detail":"{read_only:false; response_revision:9045; number_of_response:1; }","duration":"154.95802ms","start":"2026-10-26T21:44:18.098521Z","end":"2026-10-26T21:44:18.253479Z","steps":["trace[1746523478] 'process raft request'  (duration: 152.041944ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.253832Z","caller":"traceutil/trace.go:171","msg":"trace[1618761078] transaction","detail":"{read_only:false; response_revision:9046; number_of_response:1; }","duration":"155.183856ms","start":"2026-10-26T21:44:18.098631Z","end":"2026-10-26T21:44:18.253815Z","steps":["trace[1618761078] 'process raft request'  (duration: 154.308273ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.255571Z","caller":"traceutil/trace.go:171","msg":"trace[547674081] transaction","detail":"{read_only:false; response_revision:9047; number_of_response:1; }","duration":"118.596003ms","start":"2026-10-26T21:44:18.136954Z","end":"2026-10-26T21:44:18.25555Z","steps":["trace[547674081] 'process raft request'  (duration: 116.048868ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:18.255981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.076494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-l87vd\" ","response":"range_response_count:1 size:4812"}
{"level":"info","ts":"2026-10-26T21:44:18.256038Z","caller":"traceutil/trace.go:171","msg":"trace[1278266381] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-l87vd; range_end:; response_count:1; response_revision:9047; }","duration":"157.183917ms","start":"2026-10-26T21:44:18.098841Z","end":"2026-10-26T21:44:18.256025Z","steps":["trace[1278266381] 'agreement among raft nodes before linearized reading'  (duration: 156.938901ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:18.25634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.486739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-l87vd\" ","response":"range_response_count:1 size:2799"}
{"level":"info","ts":"2026-10-26T21:44:18.256408Z","caller":"traceutil/trace.go:171","msg":"trace[1759143090] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-l87vd; range_end:; response_count:1; response_revision:9047; }","duration":"156.586282ms","start":"2026-10-26T21:44:18.099799Z","end":"2026-10-26T21:44:18.256386Z","steps":["trace[1759143090] 'agreement among raft nodes before linearized reading'  (duration: 156.429268ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:18.256951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.4594ms","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-10-26T21:44:18.257022Z","caller":"traceutil/trace.go:171","msg":"trace[346547550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9047; }","duration":"123.583434ms","start":"2026-10-26T21:44:18.133424Z","end":"2026-10-26T21:44:18.257007Z","steps":["trace[346547550] 'agreement among raft nodes before linearized reading'  (duration: 123.420029ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.440752Z","caller":"traceutil/trace.go:171","msg":"trace[1173776803] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9048; }","duration":"171.764917ms","start":"2026-10-26T21:44:18.268952Z","end":"2026-10-26T21:44:18.440693Z","steps":["trace[1173776803] 'process raft request'  (duration: 157.452014ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.461323Z","caller":"traceutil/trace.go:171","msg":"trace[192067946] transaction","detail":"{read_only:false; response_revision:9049; number_of_response:1; }","duration":"191.589092ms","start":"2026-10-26T21:44:18.269673Z","end":"2026-10-26T21:44:18.461262Z","steps":["trace[192067946] 'process raft request'  (duration: 191.292485ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.461569Z","caller":"traceutil/trace.go:171","msg":"trace[358062275] linearizableReadLoop","detail":"{readStateIndex:9373; appliedIndex:9371; }","duration":"188.479691ms","start":"2026-10-26T21:44:18.273034Z","end":"2026-10-26T21:44:18.461514Z","steps":["trace[358062275] 'read index received'  (duration: 153.790139ms)","trace[358062275] 'applied index is now lower than readState.Index'  (duration: 34.687982ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:44:18.461617Z","caller":"traceutil/trace.go:171","msg":"trace[1684853650] transaction","detail":"{read_only:false; response_revision:9051; number_of_response:1; }","duration":"179.9536ms","start":"2026-10-26T21:44:18.281643Z","end":"2026-10-26T21:44:18.461597Z","steps":["trace[1684853650] 'process raft request'  (duration: 179.739404ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:18.46157Z","caller":"traceutil/trace.go:171","msg":"trace[505976266] transaction","detail":"{read_only:false; response_revision:9050; number_of_response:1; }","duration":"186.423468ms","start":"2026-10-26T21:44:18.275056Z","end":"2026-10-26T21:44:18.46148Z","steps":["trace[505976266] 'process raft request'  (duration: 186.052238ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:18.461829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.931525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-l87vd\" ","response":"range_response_count:1 size:4792"}
{"level":"info","ts":"2026-10-26T21:44:18.461874Z","caller":"traceutil/trace.go:171","msg":"trace[862380085] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-l87vd; range_end:; response_count:1; response_revision:9051; }","duration":"186.019597ms","start":"2026-10-26T21:44:18.275837Z","end":"2026-10-26T21:44:18.461856Z","steps":["trace[862380085] 'agreement among raft nodes before linearized reading'  (duration: 185.908884ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:44:18.466732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.646745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:229789"}
{"level":"info","ts":"2026-10-26T21:44:18.466802Z","caller":"traceutil/trace.go:171","msg":"trace[201416805] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9051; }","duration":"193.798149ms","start":"2026-10-26T21:44:18.272988Z","end":"2026-10-26T21:44:18.466786Z","steps":["trace[201416805] 'agreement among raft nodes before linearized reading'  (duration: 188.654305ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:44:19.142331Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024a5.wal"}
{"level":"info","ts":"2026-10-26T21:45:18.936708Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8608f4af3693a53b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T21:45:18.948449Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-26T21:45:18.948587Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-26T21:45:44.200975Z","caller":"traceutil/trace.go:171","msg":"trace[161702375] transaction","detail":"{read_only:false; response_revision:9879; number_of_response:1; }","duration":"120.629534ms","start":"2026-10-26T21:45:44.080293Z","end":"2026-10-26T21:45:44.200923Z","steps":["trace[161702375] 'process raft request'  (duration: 120.322956ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:46:50.019849Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7943}
{"level":"info","ts":"2026-10-26T21:46:50.113975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7943,"took":"91.633771ms","hash":2581773704,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":24956928,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-10-26T21:46:50.114049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2581773704,"revision":7943,"compact-revision":5529}
{"level":"info","ts":"2026-10-26T21:51:50.028891Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10338}
{"level":"info","ts":"2026-10-26T21:51:50.123527Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10338,"took":"91.726917ms","hash":195657140,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":26140672,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-26T21:51:50.123613Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":195657140,"revision":10338,"compact-revision":7943}
{"level":"info","ts":"2026-10-26T21:56:50.036124Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12504}
{"level":"info","ts":"2026-10-26T21:56:50.129241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12504,"took":"89.290753ms","hash":1729658297,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":27906048,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-26T21:56:50.12935Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1729658297,"revision":12504,"compact-revision":10338}
{"level":"info","ts":"2026-10-26T21:57:25.269244Z","caller":"traceutil/trace.go:171","msg":"trace[1623844675] transaction","detail":"{read_only:false; response_revision:14770; number_of_response:1; }","duration":"151.512412ms","start":"2026-10-26T21:57:25.117704Z","end":"2026-10-26T21:57:25.269216Z","steps":["trace[1623844675] 'process raft request'  (duration: 150.962458ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:57:47.530205Z","caller":"traceutil/trace.go:171","msg":"trace[1785505490] transaction","detail":"{read_only:false; response_revision:14885; number_of_response:1; }","duration":"125.332171ms","start":"2026-10-26T21:57:47.404842Z","end":"2026-10-26T21:57:47.530174Z","steps":["trace[1785505490] 'process raft request'  (duration: 123.644608ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:57:47.53054Z","caller":"traceutil/trace.go:171","msg":"trace[1186160045] transaction","detail":"{read_only:false; response_revision:14886; number_of_response:1; }","duration":"107.406785ms","start":"2026-10-26T21:57:47.423099Z","end":"2026-10-26T21:57:47.530506Z","steps":["trace[1186160045] 'process raft request'  (duration: 107.016594ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:58:05.718806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.294166ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11906287585709747907 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:14966 > 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-10-26T21:58:05.719293Z","caller":"traceutil/trace.go:171","msg":"trace[741712947] transaction","detail":"{read_only:false; response_revision:14991; number_of_response:1; }","duration":"157.647801ms","start":"2026-10-26T21:58:05.561611Z","end":"2026-10-26T21:58:05.719259Z","steps":["trace[741712947] 'process raft request'  (duration: 35.75234ms)","trace[741712947] 'compare'  (duration: 121.006049ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:58:05.719288Z","caller":"traceutil/trace.go:171","msg":"trace[1264569147] transaction","detail":"{read_only:false; response_revision:14992; number_of_response:1; }","duration":"111.357447ms","start":"2026-10-26T21:58:05.607886Z","end":"2026-10-26T21:58:05.719244Z","steps":["trace[1264569147] 'process raft request'  (duration: 111.147352ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:58:06.568203Z","caller":"traceutil/trace.go:171","msg":"trace[1681999450] linearizableReadLoop","detail":"{readStateIndex:15516; appliedIndex:15515; }","duration":"191.681067ms","start":"2026-10-26T21:58:06.376501Z","end":"2026-10-26T21:58:06.568182Z","steps":["trace[1681999450] 'read index received'  (duration: 191.40754ms)","trace[1681999450] 'applied index is now lower than readState.Index'  (duration: 272.657µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T21:58:06.568268Z","caller":"traceutil/trace.go:171","msg":"trace[432267006] transaction","detail":"{read_only:false; response_revision:14994; number_of_response:1; }","duration":"200.733923ms","start":"2026-10-26T21:58:06.367496Z","end":"2026-10-26T21:58:06.568229Z","steps":["trace[432267006] 'process raft request'  (duration: 200.564339ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:58:06.568376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.111975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:58:06.568401Z","caller":"traceutil/trace.go:171","msg":"trace[165371528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14994; }","duration":"135.192368ms","start":"2026-10-26T21:58:06.433202Z","end":"2026-10-26T21:58:06.568394Z","steps":["trace[165371528] 'agreement among raft nodes before linearized reading'  (duration: 135.101145ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:58:06.568461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.949355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-k5pqd\" ","response":"range_response_count:1 size:12360"}
{"level":"info","ts":"2026-10-26T21:58:06.568517Z","caller":"traceutil/trace.go:171","msg":"trace[314784834] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-k5pqd; range_end:; response_count:1; response_revision:14994; }","duration":"192.050208ms","start":"2026-10-26T21:58:06.376453Z","end":"2026-10-26T21:58:06.568503Z","steps":["trace[314784834] 'agreement among raft nodes before linearized reading'  (duration: 191.837711ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:58:17.780969Z","caller":"traceutil/trace.go:171","msg":"trace[2087845579] transaction","detail":"{read_only:false; response_revision:15171; number_of_response:1; }","duration":"179.330937ms","start":"2026-10-26T21:58:17.601583Z","end":"2026-10-26T21:58:17.780914Z","steps":["trace[2087845579] 'process raft request'  (duration: 179.110681ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T21:58:17.788879Z","caller":"traceutil/trace.go:171","msg":"trace[583776784] transaction","detail":"{read_only:false; response_revision:15172; number_of_response:1; }","duration":"169.192553ms","start":"2026-10-26T21:58:17.619663Z","end":"2026-10-26T21:58:17.788855Z","steps":["trace[583776784] 'process raft request'  (duration: 169.031379ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.615943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.677019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:59:14.616069Z","caller":"traceutil/trace.go:171","msg":"trace[547313505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15978; }","duration":"182.874793ms","start":"2026-10-26T21:59:14.433169Z","end":"2026-10-26T21:59:14.616044Z","steps":["trace[547313505] 'range keys from in-memory index tree'  (duration: 182.543265ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.616098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.577716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:59:14.616215Z","caller":"traceutil/trace.go:171","msg":"trace[2453689] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:0; response_revision:15978; }","duration":"443.738979ms","start":"2026-10-26T21:59:14.172449Z","end":"2026-10-26T21:59:14.616188Z","steps":["trace[2453689] 'range keys from in-memory index tree'  (duration: 443.423602ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.616264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.172438Z","time spent":"443.815762ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-10-26T21:59:14.61624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.968164ms","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-10-26T21:59:14.616348Z","caller":"traceutil/trace.go:171","msg":"trace[896127819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15978; }","duration":"490.338084ms","start":"2026-10-26T21:59:14.125987Z","end":"2026-10-26T21:59:14.616325Z","steps":["trace[896127819] 'range keys from in-memory index tree'  (duration: 488.716521ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.616391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.125944Z","time spent":"490.434936ms","remote":"127.0.0.1:44280","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":"warn","ts":"2026-10-26T21:59:14.616525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.981516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225401"}
{"level":"info","ts":"2026-10-26T21:59:14.616635Z","caller":"traceutil/trace.go:171","msg":"trace[682309187] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:15978; }","duration":"378.163942ms","start":"2026-10-26T21:59:14.238445Z","end":"2026-10-26T21:59:14.616609Z","steps":["trace[682309187] 'range keys from in-memory index tree'  (duration: 376.724153ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.616693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.238421Z","time spent":"378.256784ms","remote":"127.0.0.1:44108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2225425,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"warn","ts":"2026-10-26T21:59:14.616704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.750724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T21:59:14.616757Z","caller":"traceutil/trace.go:171","msg":"trace[100706467] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15978; }","duration":"442.802315ms","start":"2026-10-26T21:59:14.173939Z","end":"2026-10-26T21:59:14.616742Z","steps":["trace[100706467] 'range keys from in-memory index tree'  (duration: 442.638131ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.616811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.173853Z","time spent":"442.95088ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-10-26T21:59:14.616836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.047384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T21:59:14.616885Z","caller":"traceutil/trace.go:171","msg":"trace[965210296] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:15978; }","duration":"460.485907ms","start":"2026-10-26T21:59:14.156382Z","end":"2026-10-26T21:59:14.616868Z","steps":["trace[965210296] 'count revisions from in-memory index tree'  (duration: 459.943582ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.616878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.868358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-10-26T21:59:14.616942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.156358Z","time spent":"460.568929ms","remote":"127.0.0.1:52846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":14,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"info","ts":"2026-10-26T21:59:14.616951Z","caller":"traceutil/trace.go:171","msg":"trace[1978235026] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15978; }","duration":"442.96247ms","start":"2026-10-26T21:59:14.173969Z","end":"2026-10-26T21:59:14.616931Z","steps":["trace[1978235026] 'range keys from in-memory index tree'  (duration: 442.651662ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.617001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.173956Z","time spent":"443.032883ms","remote":"127.0.0.1:44150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":692,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-10-26T21:59:14.617298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.133296ms","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-10-26T21:59:14.617337Z","caller":"traceutil/trace.go:171","msg":"trace[1410719879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15978; }","duration":"450.192248ms","start":"2026-10-26T21:59:14.167132Z","end":"2026-10-26T21:59:14.617324Z","steps":["trace[1410719879] 'range keys from in-memory index tree'  (duration: 449.989393ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T21:59:14.617365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:59:14.167115Z","time spent":"450.243989ms","remote":"127.0.0.1:44280","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-10-26T21:59:14.622879Z","caller":"traceutil/trace.go:171","msg":"trace[1771799266] transaction","detail":"{read_only:false; response_revision:15979; number_of_response:1; }","duration":"114.898034ms","start":"2026-10-26T21:59:14.507963Z","end":"2026-10-26T21:59:14.622861Z","steps":["trace[1771799266] 'process raft request'  (duration: 114.478553ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.415162Z","caller":"traceutil/trace.go:171","msg":"trace[728807231] transaction","detail":"{read_only:false; response_revision:16286; number_of_response:1; }","duration":"152.702688ms","start":"2026-10-26T22:00:00.262413Z","end":"2026-10-26T22:00:00.415116Z","steps":["trace[728807231] 'process raft request'  (duration: 152.624306ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.415522Z","caller":"traceutil/trace.go:171","msg":"trace[1473862368] transaction","detail":"{read_only:false; response_revision:16285; number_of_response:1; }","duration":"153.138519ms","start":"2026-10-26T22:00:00.262363Z","end":"2026-10-26T22:00:00.415501Z","steps":["trace[1473862368] 'process raft request'  (duration: 152.480242ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.421365Z","caller":"traceutil/trace.go:171","msg":"trace[1521210860] linearizableReadLoop","detail":"{readStateIndex:16850; appliedIndex:16849; }","duration":"126.120185ms","start":"2026-10-26T22:00:00.295224Z","end":"2026-10-26T22:00:00.421344Z","steps":["trace[1521210860] 'read index received'  (duration: 120.130839ms)","trace[1521210860] 'applied index is now lower than readState.Index'  (duration: 5.988026ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T22:00:00.421732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.483614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-service-cleaner-29884200-jp46w\" ","response":"range_response_count:1 size:6911"}
{"level":"info","ts":"2026-10-26T22:00:00.421794Z","caller":"traceutil/trace.go:171","msg":"trace[324428365] range","detail":"{range_begin:/registry/pods/openstack/nova-service-cleaner-29884200-jp46w; range_end:; response_count:1; response_revision:16288; }","duration":"126.590517ms","start":"2026-10-26T22:00:00.295185Z","end":"2026-10-26T22:00:00.421775Z","steps":["trace[324428365] 'agreement among raft nodes before linearized reading'  (duration: 126.241248ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.422299Z","caller":"traceutil/trace.go:171","msg":"trace[1528697342] transaction","detail":"{read_only:false; response_revision:16287; number_of_response:1; }","duration":"142.105942ms","start":"2026-10-26T22:00:00.280173Z","end":"2026-10-26T22:00:00.422279Z","steps":["trace[1528697342] 'process raft request'  (duration: 141.021153ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.422536Z","caller":"traceutil/trace.go:171","msg":"trace[1681951908] transaction","detail":"{read_only:false; response_revision:16288; number_of_response:1; }","duration":"125.949411ms","start":"2026-10-26T22:00:00.296503Z","end":"2026-10-26T22:00:00.422452Z","steps":["trace[1681951908] 'process raft request'  (duration: 124.79313ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.618914Z","caller":"traceutil/trace.go:171","msg":"trace[333212282] linearizableReadLoop","detail":"{readStateIndex:16853; appliedIndex:16851; }","duration":"185.821852ms","start":"2026-10-26T22:00:00.433061Z","end":"2026-10-26T22:00:00.618882Z","steps":["trace[333212282] 'read index received'  (duration: 7.209559ms)","trace[333212282] 'applied index is now lower than readState.Index'  (duration: 178.610823ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:00:00.619063Z","caller":"traceutil/trace.go:171","msg":"trace[1870922992] transaction","detail":"{read_only:false; response_revision:16290; number_of_response:1; }","duration":"190.609775ms","start":"2026-10-26T22:00:00.428439Z","end":"2026-10-26T22:00:00.619048Z","steps":["trace[1870922992] 'process raft request'  (duration: 95.730693ms)","trace[1870922992] 'compare'  (duration: 94.382469ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T22:00:00.619156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.077238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T22:00:00.619217Z","caller":"traceutil/trace.go:171","msg":"trace[1185414770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16291; }","duration":"186.175211ms","start":"2026-10-26T22:00:00.433025Z","end":"2026-10-26T22:00:00.619201Z","steps":["trace[1185414770] 'agreement among raft nodes before linearized reading'  (duration: 186.052338ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.619492Z","caller":"traceutil/trace.go:171","msg":"trace[1666220744] transaction","detail":"{read_only:false; response_revision:16291; number_of_response:1; }","duration":"185.203684ms","start":"2026-10-26T22:00:00.434272Z","end":"2026-10-26T22:00:00.619475Z","steps":["trace[1666220744] 'process raft request'  (duration: 184.482106ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:00:00.748462Z","caller":"traceutil/trace.go:171","msg":"trace[1219995009] transaction","detail":"{read_only:false; response_revision:16292; number_of_response:1; }","duration":"107.797159ms","start":"2026-10-26T22:00:00.640622Z","end":"2026-10-26T22:00:00.748419Z","steps":["trace[1219995009] 'process raft request'  (duration: 107.570823ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:00:05.997071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.71306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T22:00:05.997198Z","caller":"traceutil/trace.go:171","msg":"trace[1073769387] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16331; }","duration":"111.885564ms","start":"2026-10-26T22:00:05.885286Z","end":"2026-10-26T22:00:05.997172Z","steps":["trace[1073769387] 'range keys from in-memory index tree'  (duration: 111.476164ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:00:05.997232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.572793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-26T22:00:05.99736Z","caller":"traceutil/trace.go:171","msg":"trace[150358362] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16331; }","duration":"145.760517ms","start":"2026-10-26T22:00:05.851571Z","end":"2026-10-26T22:00:05.997331Z","steps":["trace[150358362] 'range keys from in-memory index tree'  (duration: 145.316515ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:00:05.997715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.525761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T22:00:05.997762Z","caller":"traceutil/trace.go:171","msg":"trace[2011555448] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16331; }","duration":"112.617793ms","start":"2026-10-26T22:00:05.885134Z","end":"2026-10-26T22:00:05.997752Z","steps":["trace[2011555448] 'range keys from in-memory index tree'  (duration: 112.428909ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:00:05.99789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.732207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T22:00:05.997924Z","caller":"traceutil/trace.go:171","msg":"trace[992023263] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16331; }","duration":"112.815699ms","start":"2026-10-26T22:00:05.8851Z","end":"2026-10-26T22:00:05.997915Z","steps":["trace[992023263] 'range keys from in-memory index tree'  (duration: 112.580283ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:00:05.998798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.038209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-29884200-jwhsl\" ","response":"range_response_count:1 size:7039"}
{"level":"info","ts":"2026-10-26T22:00:05.998876Z","caller":"traceutil/trace.go:171","msg":"trace[1899263861] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-29884200-jwhsl; range_end:; response_count:1; response_revision:16331; }","duration":"171.111007ms","start":"2026-10-26T22:00:05.82775Z","end":"2026-10-26T22:00:05.998861Z","steps":["trace[1899263861] 'range keys from in-memory index tree'  (duration: 169.877496ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:01:50.043193Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14506}
{"level":"info","ts":"2026-10-26T22:01:50.134395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14506,"took":"87.831618ms","hash":871105366,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":31588352,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T22:01:50.134483Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":871105366,"revision":14506,"compact-revision":12504}
{"level":"info","ts":"2026-10-26T22:05:35.767278Z","caller":"traceutil/trace.go:171","msg":"trace[1160599998] transaction","detail":"{read_only:false; response_revision:18818; number_of_response:1; }","duration":"199.79897ms","start":"2026-10-26T22:05:35.567421Z","end":"2026-10-26T22:05:35.76722Z","steps":["trace[1160599998] 'process raft request'  (duration: 199.628835ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:05:35.767314Z","caller":"traceutil/trace.go:171","msg":"trace[1041039534] linearizableReadLoop","detail":"{readStateIndex:19465; appliedIndex:19465; }","duration":"178.853091ms","start":"2026-10-26T22:05:35.588402Z","end":"2026-10-26T22:05:35.767255Z","steps":["trace[1041039534] 'read index received'  (duration: 178.830729ms)","trace[1041039534] 'applied index is now lower than readState.Index'  (duration: 18.281µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T22:05:35.767613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.157359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T22:05:35.767723Z","caller":"traceutil/trace.go:171","msg":"trace[1067385483] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:18818; }","duration":"179.333913ms","start":"2026-10-26T22:05:35.588362Z","end":"2026-10-26T22:05:35.767696Z","steps":["trace[1067385483] 'agreement among raft nodes before linearized reading'  (duration: 179.022505ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:05:35.770426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.708164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T22:05:35.770498Z","caller":"traceutil/trace.go:171","msg":"trace[2018423892] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:18820; }","duration":"163.803886ms","start":"2026-10-26T22:05:35.606674Z","end":"2026-10-26T22:05:35.770478Z","steps":["trace[2018423892] 'agreement among raft nodes before linearized reading'  (duration: 163.656962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:05:43.320447Z","caller":"traceutil/trace.go:171","msg":"trace[999538891] transaction","detail":"{read_only:false; response_revision:18869; number_of_response:1; }","duration":"194.471461ms","start":"2026-10-26T22:05:43.125933Z","end":"2026-10-26T22:05:43.320405Z","steps":["trace[999538891] 'process raft request'  (duration: 117.292986ms)","trace[999538891] 'compare'  (duration: 76.873507ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:05:43.32668Z","caller":"traceutil/trace.go:171","msg":"trace[1050462992] transaction","detail":"{read_only:false; response_revision:18870; number_of_response:1; }","duration":"200.503569ms","start":"2026-10-26T22:05:43.126142Z","end":"2026-10-26T22:05:43.326646Z","steps":["trace[1050462992] 'process raft request'  (duration: 200.342854ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:05:44.050583Z","caller":"traceutil/trace.go:171","msg":"trace[1458616127] transaction","detail":"{read_only:false; response_revision:18871; number_of_response:1; }","duration":"247.152182ms","start":"2026-10-26T22:05:43.803399Z","end":"2026-10-26T22:05:44.050551Z","steps":["trace[1458616127] 'process raft request'  (duration: 246.917736ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:05:44.238557Z","caller":"traceutil/trace.go:171","msg":"trace[1408616334] linearizableReadLoop","detail":"{readStateIndex:19520; appliedIndex:19518; }","duration":"432.053931ms","start":"2026-10-26T22:05:43.806469Z","end":"2026-10-26T22:05:44.238523Z","steps":["trace[1408616334] 'read index received'  (duration: 244.001849ms)","trace[1408616334] 'applied index is now lower than readState.Index'  (duration: 188.050562ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:05:44.238705Z","caller":"traceutil/trace.go:171","msg":"trace[1099322220] transaction","detail":"{read_only:false; response_revision:18872; number_of_response:1; }","duration":"432.76163ms","start":"2026-10-26T22:05:43.805881Z","end":"2026-10-26T22:05:44.238643Z","steps":["trace[1099322220] 'process raft request'  (duration: 432.423601ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:05:44.238924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:05:43.805848Z","time spent":"432.966956ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":21014,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-mmxqt\" mod_revision:18804 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-mmxqt\" value_size:20950 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-mmxqt\" > >"}
{"level":"warn","ts":"2026-10-26T22:05:44.239076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.570675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.22\" ","response":"range_response_count:1 size:137"}
{"level":"warn","ts":"2026-10-26T22:05:44.239228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.213951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-10-26T22:05:44.23928Z","caller":"traceutil/trace.go:171","msg":"trace[830242951] range","detail":"{range_begin:/registry/masterleases/162.253.55.22; range_end:; response_count:1; response_revision:18872; }","duration":"432.75099ms","start":"2026-10-26T22:05:43.806431Z","end":"2026-10-26T22:05:44.239182Z","steps":["trace[830242951] 'agreement among raft nodes before linearized reading'  (duration: 432.295978ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:05:44.2393Z","caller":"traceutil/trace.go:171","msg":"trace[1788623337] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:18872; }","duration":"216.370586ms","start":"2026-10-26T22:05:44.022909Z","end":"2026-10-26T22:05:44.239279Z","steps":["trace[1788623337] 'agreement among raft nodes before linearized reading'  (duration: 216.022517ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:05:44.239353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.346191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-10-26T22:05:44.239369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:05:43.80642Z","time spent":"432.936275ms","remote":"127.0.0.1:44026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/162.253.55.22\" "}
{"level":"info","ts":"2026-10-26T22:05:44.239413Z","caller":"traceutil/trace.go:171","msg":"trace[556828437] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:18872; }","duration":"331.477175ms","start":"2026-10-26T22:05:43.907916Z","end":"2026-10-26T22:05:44.239393Z","steps":["trace[556828437] 'agreement among raft nodes before linearized reading'  (duration: 331.150706ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:05:44.239448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:05:43.907887Z","time spent":"331.552647ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-26T22:05:44.239572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.686716ms","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-10-26T22:05:44.239698Z","caller":"traceutil/trace.go:171","msg":"trace[1359167914] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18872; }","duration":"430.865921ms","start":"2026-10-26T22:05:43.808801Z","end":"2026-10-26T22:05:44.239667Z","steps":["trace[1359167914] 'agreement among raft nodes before linearized reading'  (duration: 430.095981ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:05:44.239756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:05:43.808791Z","time spent":"430.950303ms","remote":"127.0.0.1:44280","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":"warn","ts":"2026-10-26T22:05:44.239799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.340647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"}
{"level":"warn","ts":"2026-10-26T22:05:44.239798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.131141ms","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-10-26T22:05:44.239854Z","caller":"traceutil/trace.go:171","msg":"trace[397471665] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18872; }","duration":"292.419269ms","start":"2026-10-26T22:05:43.94742Z","end":"2026-10-26T22:05:44.239839Z","steps":["trace[397471665] 'agreement among raft nodes before linearized reading'  (duration: 291.625309ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:05:44.23991Z","caller":"traceutil/trace.go:171","msg":"trace[1197106002] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18872; }","duration":"242.284374ms","start":"2026-10-26T22:05:43.9976Z","end":"2026-10-26T22:05:44.239884Z","steps":["trace[1197106002] 'agreement among raft nodes before linearized reading'  (duration: 241.533505ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:05:44.241917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.596945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T22:05:44.24223Z","caller":"traceutil/trace.go:171","msg":"trace[500137780] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:18872; }","duration":"197.687805ms","start":"2026-10-26T22:05:44.04452Z","end":"2026-10-26T22:05:44.242207Z","steps":["trace[500137780] 'agreement among raft nodes before linearized reading'  (duration: 194.586664ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:06:27.728112Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8608f4af3693a53b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T22:06:27.741159Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-26T22:06:27.741319Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-26T22:06:37.82064Z","caller":"traceutil/trace.go:171","msg":"trace[999123019] transaction","detail":"{read_only:false; response_revision:19556; number_of_response:1; }","duration":"106.602326ms","start":"2026-10-26T22:06:37.714006Z","end":"2026-10-26T22:06:37.820608Z","steps":["trace[999123019] 'process raft request'  (duration: 106.492123ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:06:50.05687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16997}
{"level":"info","ts":"2026-10-26T22:06:50.16382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16997,"took":"103.576286ms","hash":78186735,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":34816000,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-26T22:06:50.163926Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":78186735,"revision":16997,"compact-revision":14506}
{"level":"info","ts":"2026-10-26T22:11:46.919541Z","caller":"traceutil/trace.go:171","msg":"trace[570110495] linearizableReadLoop","detail":"{readStateIndex:22414; appliedIndex:22413; }","duration":"390.804603ms","start":"2026-10-26T22:11:46.528711Z","end":"2026-10-26T22:11:46.919516Z","steps":["trace[570110495] 'read index received'  (duration: 390.609208ms)","trace[570110495] 'applied index is now lower than readState.Index'  (duration: 194.005µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:11:46.919621Z","caller":"traceutil/trace.go:171","msg":"trace[612490229] transaction","detail":"{read_only:false; response_revision:21675; number_of_response:1; }","duration":"406.023359ms","start":"2026-10-26T22:11:46.513561Z","end":"2026-10-26T22:11:46.919584Z","steps":["trace[612490229] 'process raft request'  (duration: 405.746052ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:11:46.919795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.08633ms","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-10-26T22:11:46.919838Z","caller":"traceutil/trace.go:171","msg":"trace[1282297781] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21675; }","duration":"391.216065ms","start":"2026-10-26T22:11:46.528609Z","end":"2026-10-26T22:11:46.919825Z","steps":["trace[1282297781] 'agreement among raft nodes before linearized reading'  (duration: 391.083921ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:11:46.919867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:11:46.52856Z","time spent":"391.299196ms","remote":"127.0.0.1:44280","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":"warn","ts":"2026-10-26T22:11:46.919795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:11:46.513519Z","time spent":"406.167404ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21665 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-26T22:11:46.941941Z","caller":"traceutil/trace.go:171","msg":"trace[296995036] transaction","detail":"{read_only:false; response_revision:21676; number_of_response:1; }","duration":"351.61322ms","start":"2026-10-26T22:11:46.590271Z","end":"2026-10-26T22:11:46.941885Z","steps":["trace[296995036] 'process raft request'  (duration: 351.444576ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:11:46.941978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.224333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-10-26T22:11:46.942168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:11:46.590251Z","time spent":"351.806887ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21667 > 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-10-26T22:11:46.942195Z","caller":"traceutil/trace.go:171","msg":"trace[120457271] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:21676; }","duration":"233.507602ms","start":"2026-10-26T22:11:46.70867Z","end":"2026-10-26T22:11:46.942178Z","steps":["trace[120457271] 'agreement among raft nodes before linearized reading'  (duration: 233.181862ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:11:47.149268Z","caller":"traceutil/trace.go:171","msg":"trace[852112496] transaction","detail":"{read_only:false; response_revision:21678; number_of_response:1; }","duration":"201.607038ms","start":"2026-10-26T22:11:46.947605Z","end":"2026-10-26T22:11:47.149212Z","steps":["trace[852112496] 'process raft request'  (duration: 153.513533ms)","trace[852112496] 'compare'  (duration: 47.91878ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:11:47.964909Z","caller":"traceutil/trace.go:171","msg":"trace[1725418194] transaction","detail":"{read_only:false; response_revision:21681; number_of_response:1; }","duration":"202.684567ms","start":"2026-10-26T22:11:47.76219Z","end":"2026-10-26T22:11:47.964875Z","steps":["trace[1725418194] 'process raft request'  (duration: 202.484372ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:11:50.065176Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19654}
{"level":"info","ts":"2026-10-26T22:11:50.210074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19654,"took":"139.769506ms","hash":2389034936,"current-db-size-bytes":55349248,"current-db-size":"55 MB","current-db-size-in-use-bytes":30502912,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-26T22:11:50.21022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2389034936,"revision":19654,"compact-revision":16997}
{"level":"info","ts":"2026-10-26T22:15:54.271971Z","caller":"traceutil/trace.go:171","msg":"trace[490704886] transaction","detail":"{read_only:false; response_revision:24198; number_of_response:1; }","duration":"296.683378ms","start":"2026-10-26T22:15:53.975259Z","end":"2026-10-26T22:15:54.271942Z","steps":["trace[490704886] 'process raft request'  (duration: 296.510654ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:15:54.273171Z","caller":"traceutil/trace.go:171","msg":"trace[1199563325] transaction","detail":"{read_only:false; response_revision:24199; number_of_response:1; }","duration":"240.594085ms","start":"2026-10-26T22:15:54.032547Z","end":"2026-10-26T22:15:54.273141Z","steps":["trace[1199563325] 'process raft request'  (duration: 240.300497ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:15:54.273249Z","caller":"traceutil/trace.go:171","msg":"trace[185264914] transaction","detail":"{read_only:false; response_revision:24200; number_of_response:1; }","duration":"214.786921ms","start":"2026-10-26T22:15:54.058447Z","end":"2026-10-26T22:15:54.273234Z","steps":["trace[185264914] 'process raft request'  (duration: 214.578186ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:15:54.273159Z","caller":"traceutil/trace.go:171","msg":"trace[1376591865] transaction","detail":"{read_only:false; response_revision:24201; number_of_response:1; }","duration":"179.457921ms","start":"2026-10-26T22:15:54.093663Z","end":"2026-10-26T22:15:54.273121Z","steps":["trace[1376591865] 'process raft request'  (duration: 179.40516ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:16:50.072036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21693}
{"level":"info","ts":"2026-10-26T22:16:50.194704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21693,"took":"116.855308ms","hash":1492008428,"current-db-size-bytes":55775232,"current-db-size":"56 MB","current-db-size-in-use-bytes":42586112,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-10-26T22:16:50.194813Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1492008428,"revision":21693,"compact-revision":19654}
{"level":"info","ts":"2026-10-26T22:17:25.543097Z","caller":"traceutil/trace.go:171","msg":"trace[966840634] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"119.328223ms","start":"2026-10-26T22:17:25.423716Z","end":"2026-10-26T22:17:25.543044Z","steps":["trace[966840634] 'process raft request'  (duration: 90.545003ms)","trace[966840634] 'compare'  (duration: 28.631696ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:18:45.924893Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006862.wal"}
{"level":"info","ts":"2026-10-26T22:19:26.896042Z","caller":"traceutil/trace.go:171","msg":"trace[1742638062] transaction","detail":"{read_only:false; response_revision:26247; number_of_response:1; }","duration":"106.258812ms","start":"2026-10-26T22:19:26.789746Z","end":"2026-10-26T22:19:26.896005Z","steps":["trace[1742638062] 'process raft request'  (duration: 106.002495ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:19:26.902214Z","caller":"traceutil/trace.go:171","msg":"trace[1214666285] transaction","detail":"{read_only:false; response_revision:26248; number_of_response:1; }","duration":"110.233145ms","start":"2026-10-26T22:19:26.791958Z","end":"2026-10-26T22:19:26.902192Z","steps":["trace[1214666285] 'process raft request'  (duration: 110.127813ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:19:27.352093Z","caller":"traceutil/trace.go:171","msg":"trace[1579503340] linearizableReadLoop","detail":"{readStateIndex:27121; appliedIndex:27120; }","duration":"125.853243ms","start":"2026-10-26T22:19:27.2262Z","end":"2026-10-26T22:19:27.352053Z","steps":["trace[1579503340] 'read index received'  (duration: 125.669477ms)","trace[1579503340] 'applied index is now lower than readState.Index'  (duration: 182.016µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:19:27.352164Z","caller":"traceutil/trace.go:171","msg":"trace[132544834] transaction","detail":"{read_only:false; response_revision:26249; number_of_response:1; }","duration":"170.702902ms","start":"2026-10-26T22:19:27.181411Z","end":"2026-10-26T22:19:27.352114Z","steps":["trace[132544834] 'process raft request'  (duration: 170.390063ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:19:27.35257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.317494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-10-26T22:19:27.352704Z","caller":"traceutil/trace.go:171","msg":"trace[1475694915] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:26249; }","duration":"126.520139ms","start":"2026-10-26T22:19:27.226146Z","end":"2026-10-26T22:19:27.352666Z","steps":["trace[1475694915] 'agreement among raft nodes before linearized reading'  (duration: 126.081838ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:20:30.247471Z","caller":"traceutil/trace.go:171","msg":"trace[1855637776] linearizableReadLoop","detail":"{readStateIndex:27734; appliedIndex:27733; }","duration":"224.42933ms","start":"2026-10-26T22:20:30.022994Z","end":"2026-10-26T22:20:30.247423Z","steps":["trace[1855637776] 'read index received'  (duration: 224.185834ms)","trace[1855637776] 'applied index is now lower than readState.Index'  (duration: 242.136µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:20:30.247555Z","caller":"traceutil/trace.go:171","msg":"trace[1420741053] transaction","detail":"{read_only:false; response_revision:26847; number_of_response:1; }","duration":"264.287399ms","start":"2026-10-26T22:20:29.983219Z","end":"2026-10-26T22:20:30.247506Z","steps":["trace[1420741053] 'process raft request'  (duration: 263.897309ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.247737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.675986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T22:20:30.247877Z","caller":"traceutil/trace.go:171","msg":"trace[82164316] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:26847; }","duration":"224.905313ms","start":"2026-10-26T22:20:30.022937Z","end":"2026-10-26T22:20:30.247842Z","steps":["trace[82164316] 'agreement among raft nodes before linearized reading'  (duration: 224.640216ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.4652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.816334ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11906287585709784628 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:26277 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:419179 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T22:20:30.465456Z","caller":"traceutil/trace.go:171","msg":"trace[233673629] linearizableReadLoop","detail":"{readStateIndex:27736; appliedIndex:27734; }","duration":"217.837018ms","start":"2026-10-26T22:20:30.247599Z","end":"2026-10-26T22:20:30.465436Z","steps":["trace[233673629] 'read index received'  (duration: 54.505061ms)","trace[233673629] 'applied index is now lower than readState.Index'  (duration: 163.330917ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:20:30.466116Z","caller":"traceutil/trace.go:171","msg":"trace[1764554188] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"380.793726ms","start":"2026-10-26T22:20:30.085306Z","end":"2026-10-26T22:20:30.4661Z","steps":["trace[1764554188] 'process raft request'  (duration: 216.969376ms)","trace[1764554188] 'compare'  (duration: 162.26647ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T22:20:30.466201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.085279Z","time spent":"380.880439ms","remote":"127.0.0.1:47972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419247,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:26277 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:419179 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"info","ts":"2026-10-26T22:20:30.466526Z","caller":"traceutil/trace.go:171","msg":"trace[129120565] transaction","detail":"{read_only:false; response_revision:26849; number_of_response:1; }","duration":"248.125197ms","start":"2026-10-26T22:20:30.218386Z","end":"2026-10-26T22:20:30.466511Z","steps":["trace[129120565] 'process raft request'  (duration: 246.963527ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.466771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.330424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-26T22:20:30.46681Z","caller":"traceutil/trace.go:171","msg":"trace[2096210690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26849; }","duration":"235.410096ms","start":"2026-10-26T22:20:30.231389Z","end":"2026-10-26T22:20:30.466799Z","steps":["trace[2096210690] 'agreement among raft nodes before linearized reading'  (duration: 235.282553ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.466965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.925949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T22:20:30.46702Z","caller":"traceutil/trace.go:171","msg":"trace[1509036304] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:26849; }","duration":"320.036703ms","start":"2026-10-26T22:20:30.146975Z","end":"2026-10-26T22:20:30.467012Z","steps":["trace[1509036304] 'agreement among raft nodes before linearized reading'  (duration: 319.957021ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.467053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.146945Z","time spent":"320.100344ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":32,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T22:20:30.467526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.250536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-26T22:20:30.467614Z","caller":"traceutil/trace.go:171","msg":"trace[541603097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26849; }","duration":"425.382079ms","start":"2026-10-26T22:20:30.042215Z","end":"2026-10-26T22:20:30.467597Z","steps":["trace[541603097] 'agreement among raft nodes before linearized reading'  (duration: 425.206794ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.467653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.042204Z","time spent":"425.44142ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-26T22:20:30.467701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.352962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-26T22:20:30.467747Z","caller":"traceutil/trace.go:171","msg":"trace[1988638333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26849; }","duration":"340.461485ms","start":"2026-10-26T22:20:30.127275Z","end":"2026-10-26T22:20:30.467737Z","steps":["trace[1988638333] 'agreement among raft nodes before linearized reading'  (duration: 340.344102ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:30.467781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.12725Z","time spent":"340.525036ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-26T22:20:31.000004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.353661ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11906287585709784634 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26835 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T22:20:31.000445Z","caller":"traceutil/trace.go:171","msg":"trace[1116179491] linearizableReadLoop","detail":"{readStateIndex:27741; appliedIndex:27736; }","duration":"335.040024ms","start":"2026-10-26T22:20:30.665379Z","end":"2026-10-26T22:20:31.000419Z","steps":["trace[1116179491] 'read index received'  (duration: 146.027796ms)","trace[1116179491] 'applied index is now lower than readState.Index'  (duration: 189.010498ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T22:20:31.000566Z","caller":"traceutil/trace.go:171","msg":"trace[233476164] transaction","detail":"{read_only:false; response_revision:26850; number_of_response:1; }","duration":"527.061539ms","start":"2026-10-26T22:20:30.473487Z","end":"2026-10-26T22:20:31.000549Z","steps":["trace[233476164] 'process raft request'  (duration: 150.00964ms)","trace[233476164] 'compare'  (duration: 376.074574ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T22:20:31.000655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.473455Z","time spent":"527.151021ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26835 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-26T22:20:31.000736Z","caller":"traceutil/trace.go:171","msg":"trace[996795749] transaction","detail":"{read_only:false; response_revision:26852; number_of_response:1; }","duration":"521.860513ms","start":"2026-10-26T22:20:30.47883Z","end":"2026-10-26T22:20:31.000691Z","steps":["trace[996795749] 'process raft request'  (duration: 521.37863ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:20:31.000788Z","caller":"traceutil/trace.go:171","msg":"trace[269861922] transaction","detail":"{read_only:false; response_revision:26853; number_of_response:1; }","duration":"516.589286ms","start":"2026-10-26T22:20:30.484141Z","end":"2026-10-26T22:20:31.00073Z","steps":["trace[269861922] 'process raft request'  (duration: 516.138304ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:31.000839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.434374ms","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-10-26T22:20:31.000942Z","caller":"traceutil/trace.go:171","msg":"trace[1076212535] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:26854; }","duration":"335.598959ms","start":"2026-10-26T22:20:30.665322Z","end":"2026-10-26T22:20:31.000921Z","steps":["trace[1076212535] 'agreement among raft nodes before linearized reading'  (duration: 335.341962ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:31.000982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.665299Z","time spent":"335.67604ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":22,"response size":32,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-10-26T22:20:31.000906Z","caller":"traceutil/trace.go:171","msg":"trace[500059992] transaction","detail":"{read_only:false; response_revision:26854; number_of_response:1; }","duration":"467.122896ms","start":"2026-10-26T22:20:30.533558Z","end":"2026-10-26T22:20:31.000681Z","steps":["trace[500059992] 'process raft request'  (duration: 466.783138ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:31.001005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.484129Z","time spent":"516.750469ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26838 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-26T22:20:31.001012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.478794Z","time spent":"522.067878ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26837 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-26T22:20:31.001071Z","caller":"traceutil/trace.go:171","msg":"trace[869879753] transaction","detail":"{read_only:false; response_revision:26851; number_of_response:1; }","duration":"527.546101ms","start":"2026-10-26T22:20:30.473498Z","end":"2026-10-26T22:20:31.001044Z","steps":["trace[869879753] 'process raft request'  (duration: 526.647438ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:31.001156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.533486Z","time spent":"467.554088ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26839 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-26T22:20:31.001177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T22:20:30.473462Z","time spent":"527.665724ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26834 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-26T22:20:31.073678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.584087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-26T22:20:31.073773Z","caller":"traceutil/trace.go:171","msg":"trace[1819077250] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26855; }","duration":"269.69359ms","start":"2026-10-26T22:20:30.804056Z","end":"2026-10-26T22:20:31.073749Z","steps":["trace[1819077250] 'agreement among raft nodes before linearized reading'  (duration: 269.402033ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:31.073757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.33182ms","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-10-26T22:20:31.073834Z","caller":"traceutil/trace.go:171","msg":"trace[73516887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26855; }","duration":"236.437043ms","start":"2026-10-26T22:20:30.83738Z","end":"2026-10-26T22:20:31.073817Z","steps":["trace[73516887] 'agreement among raft nodes before linearized reading'  (duration: 236.142955ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T22:20:31.073881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.446956ms","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-10-26T22:20:31.074008Z","caller":"traceutil/trace.go:171","msg":"trace[751350443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26855; }","duration":"238.64171ms","start":"2026-10-26T22:20:30.835344Z","end":"2026-10-26T22:20:31.073986Z","steps":["trace[751350443] 'agreement among raft nodes before linearized reading'  (duration: 238.25452ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:20:31.074208Z","caller":"traceutil/trace.go:171","msg":"trace[691223476] transaction","detail":"{read_only:false; response_revision:26855; number_of_response:1; }","duration":"267.787651ms","start":"2026-10-26T22:20:30.805992Z","end":"2026-10-26T22:20:31.07378Z","steps":["trace[691223476] 'process raft request'  (duration: 267.296318ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T22:21:50.079724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24759}
{"level":"info","ts":"2026-10-26T22:21:50.26186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24759,"took":"175.68305ms","hash":3029740849,"current-db-size-bytes":57462784,"current-db-size":"58 MB","current-db-size-in-use-bytes":35926016,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-26T22:21:50.26198Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3029740849,"revision":24759,"compact-revision":21693}
{"level":"info","ts":"2026-10-26T22:24:21.961874Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8608f4af3693a53b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T22:24:21.968901Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-26T22:24:21.96902Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-26T22:26:50.087464Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27613}
{"level":"info","ts":"2026-10-26T22:26:50.234404Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27613,"took":"142.183147ms","hash":737375070,"current-db-size-bytes":58306560,"current-db-size":"58 MB","current-db-size-in-use-bytes":34615296,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-26T22:26:50.23448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":737375070,"revision":27613,"compact-revision":24759}
{"level":"info","ts":"2026-10-26T22:31:50.095591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30307}
{"level":"info","ts":"2026-10-26T22:31:50.26714Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30307,"took":"166.50493ms","hash":9944678,"current-db-size-bytes":58306560,"current-db-size":"58 MB","current-db-size-in-use-bytes":30568448,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T22:31:50.26722Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":9944678,"revision":30307,"compact-revision":27613}
{"level":"info","ts":"2026-10-26T22:36:50.102602Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32559}
{"level":"info","ts":"2026-10-26T22:36:50.263213Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32559,"took":"155.939705ms","hash":1863552828,"current-db-size-bytes":59346944,"current-db-size":"59 MB","current-db-size-in-use-bytes":30109696,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-26T22:36:50.263278Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1863552828,"revision":32559,"compact-revision":30307}
{"level":"info","ts":"2026-10-26T22:41:50.110632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34781}
{"level":"info","ts":"2026-10-26T22:41:50.265388Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34781,"took":"149.742074ms","hash":3340090249,"current-db-size-bytes":59346944,"current-db-size":"59 MB","current-db-size-in-use-bytes":31178752,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T22:41:50.265455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3340090249,"revision":34781,"compact-revision":32559}
{"level":"info","ts":"2026-10-26T22:45:33.820801Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8608f4af3693a53b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T22:45:33.827001Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-26T22:45:33.827116Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-26T22:46:50.12535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37076}
{"level":"info","ts":"2026-10-26T22:46:50.265226Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37076,"took":"133.803687ms","hash":206796941,"current-db-size-bytes":59346944,"current-db-size":"59 MB","current-db-size-in-use-bytes":32239616,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T22:46:50.265455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":206796941,"revision":37076,"compact-revision":34781}
{"level":"info","ts":"2026-10-26T22:51:50.132877Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39351}
{"level":"info","ts":"2026-10-26T22:51:50.267822Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39351,"took":"130.891982ms","hash":1314550001,"current-db-size-bytes":59768832,"current-db-size":"60 MB","current-db-size-in-use-bytes":31580160,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T22:51:50.26789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1314550001,"revision":39351,"compact-revision":37076}
{"level":"info","ts":"2026-10-26T22:56:50.141575Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41581}
{"level":"info","ts":"2026-10-26T22:56:50.26879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41581,"took":"123.407476ms","hash":4288472825,"current-db-size-bytes":59768832,"current-db-size":"60 MB","current-db-size-in-use-bytes":29466624,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-26T22:56:50.268866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4288472825,"revision":41581,"compact-revision":39351}