{"level":"warn","ts":"2026-02-25T19:50:44.483013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:50:44.483176Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52: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.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-02-25T19:50:44.483297Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:50:44.483322Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-02-25T19:50:44.483356Z","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-02-25T19:50:44.484566Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]}
{"level":"info","ts":"2026-02-25T19:50:44.484714Z","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.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-02-25T19:50:44.489444Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.319974ms"}
{"level":"info","ts":"2026-02-25T19:50:44.497668Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-02-25T19:50:44.497756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T19:50:44.497778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-02-25T19:50:44.497788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T19:50:44.497804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-02-25T19:50:44.497842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-02-25T19:50:44.511549Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T19:50:44.515047Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T19:50:44.516452Z","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-02-25T19:50:44.518938Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T19:50:44.519176Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T19:50:44.519317Z","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-02-25T19:50:44.519378Z","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-02-25T19:50:44.51939Z","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-02-25T19:50:44.521066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-02-25T19:50:44.521585Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-02-25T19:50:44.524409Z","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-02-25T19:50:44.524553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-02-25T19:50:44.52462Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-02-25T19:50:44.524854Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T19:50:44.524915Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T19:50:44.698027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T19:50:44.698101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T19:50:44.698143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-02-25T19:50:44.698166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-02-25T19:50:44.698178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-02-25T19:50:44.698194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-02-25T19:50:44.698209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-02-25T19:50:44.699349Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:50:44.700474Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T19:50:44.700653Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:50:44.700736Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:50:44.703738Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T19:50:44.703826Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T19:50:44.704986Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-02-25T19:50:44.705003Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T19:50:44.705228Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:50:44.705358Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:50:44.705402Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-02-25T19:50:57.091953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.732482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-9sgbp\" ","response":"range_response_count:1 size:4462"}
{"level":"info","ts":"2026-02-25T19:50:57.09209Z","caller":"traceutil/trace.go:171","msg":"trace[494164466] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-9sgbp; range_end:; response_count:1; response_revision:399; }","duration":"158.926147ms","start":"2026-02-25T19:50:56.933147Z","end":"2026-02-25T19:50:57.092074Z","steps":["trace[494164466] 'range keys from in-memory index tree'  (duration: 158.65489ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:20.132599Z","caller":"traceutil/trace.go:171","msg":"trace[1476660574] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"131.224792ms","start":"2026-02-25T19:51:20.001349Z","end":"2026-02-25T19:51:20.132574Z","steps":["trace[1476660574] 'process raft request'  (duration: 131.039028ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:20.909263Z","caller":"traceutil/trace.go:171","msg":"trace[2114809079] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"173.054682ms","start":"2026-02-25T19:51:20.736173Z","end":"2026-02-25T19:51:20.909228Z","steps":["trace[2114809079] 'read index received'  (duration: 172.857036ms)","trace[2114809079] 'applied index is now lower than readState.Index'  (duration: 196.456µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:51:20.909328Z","caller":"traceutil/trace.go:171","msg":"trace[1475967829] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"274.046174ms","start":"2026-02-25T19:51:20.635251Z","end":"2026-02-25T19:51:20.909297Z","steps":["trace[1475967829] 'process raft request'  (duration: 273.810918ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:51:20.90949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.289068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-25T19:51:20.909536Z","caller":"traceutil/trace.go:171","msg":"trace[1171184312] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"173.383629ms","start":"2026-02-25T19:51:20.736141Z","end":"2026-02-25T19:51:20.909524Z","steps":["trace[1171184312] 'agreement among raft nodes before linearized reading'  (duration: 173.202765ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:51:21.104138Z","caller":"traceutil/trace.go:171","msg":"trace[887355633] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"189.532507ms","start":"2026-02-25T19:51:20.914577Z","end":"2026-02-25T19:51:21.104109Z","steps":["trace[887355633] 'process raft request'  (duration: 189.385043ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:24.83538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.61682ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555408187 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1500 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:52:24.835502Z","caller":"traceutil/trace.go:171","msg":"trace[327978952] linearizableReadLoop","detail":"{readStateIndex:1628; appliedIndex:1627; }","duration":"232.67214ms","start":"2026-02-25T19:52:24.602813Z","end":"2026-02-25T19:52:24.835485Z","steps":["trace[327978952] 'read index received'  (duration: 37.871µs)","trace[327978952] 'applied index is now lower than readState.Index'  (duration: 232.633139ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:52:24.835536Z","caller":"traceutil/trace.go:171","msg":"trace[845026954] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"330.748062ms","start":"2026-02-25T19:52:24.504752Z","end":"2026-02-25T19:52:24.8355Z","steps":["trace[845026954] 'process raft request'  (duration: 72.310441ms)","trace[845026954] 'compare'  (duration: 257.503116ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:52:24.835695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.891045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.1897954e9002185f\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-02-25T19:52:24.835737Z","caller":"traceutil/trace.go:171","msg":"trace[1685742095] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.1897954e9002185f; range_end:; response_count:1; response_revision:1570; }","duration":"232.977897ms","start":"2026-02-25T19:52:24.602747Z","end":"2026-02-25T19:52:24.835725Z","steps":["trace[1685742095] 'agreement among raft nodes before linearized reading'  (duration: 232.809703ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:24.83579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:52:24.504722Z","time spent":"330.948808ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1500 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-02-25T19:52:24.854667Z","caller":"traceutil/trace.go:171","msg":"trace[858623410] transaction","detail":"{read_only:false; response_revision:1571; number_of_response:1; }","duration":"148.957638ms","start":"2026-02-25T19:52:24.705676Z","end":"2026-02-25T19:52:24.854634Z","steps":["trace[858623410] 'process raft request'  (duration: 148.837055ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:52:25.231857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.551286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ccadc420-c1d9-4fcc-a552-0f976e1b8d0b\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-02-25T19:52:25.23196Z","caller":"traceutil/trace.go:171","msg":"trace[2101926022] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ccadc420-c1d9-4fcc-a552-0f976e1b8d0b; range_end:; response_count:1; response_revision:1574; }","duration":"138.74062ms","start":"2026-02-25T19:52:25.093194Z","end":"2026-02-25T19:52:25.231934Z","steps":["trace[2101926022] 'range keys from in-memory index tree'  (duration: 138.197886ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:53:09.148914Z","caller":"traceutil/trace.go:171","msg":"trace[1049307591] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"116.937091ms","start":"2026-02-25T19:53:09.031938Z","end":"2026-02-25T19:53:09.148875Z","steps":["trace[1049307591] 'process raft request'  (duration: 83.490618ms)","trace[1049307591] 'compare'  (duration: 33.139074ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:53:15.282873Z","caller":"traceutil/trace.go:171","msg":"trace[1404345666] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"113.603039ms","start":"2026-02-25T19:53:15.169217Z","end":"2026-02-25T19:53:15.28282Z","steps":["trace[1404345666] 'process raft request'  (duration: 105.078006ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:54:39.620722Z","caller":"traceutil/trace.go:171","msg":"trace[2119256421] linearizableReadLoop","detail":"{readStateIndex:2578; appliedIndex:2577; }","duration":"139.372551ms","start":"2026-02-25T19:54:39.481207Z","end":"2026-02-25T19:54:39.620579Z","steps":["trace[2119256421] 'read index received'  (duration: 133.441552ms)","trace[2119256421] 'applied index is now lower than readState.Index'  (duration: 5.928369ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:54:39.621128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.885864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T19:54:39.621219Z","caller":"traceutil/trace.go:171","msg":"trace[1667939317] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2483; }","duration":"140.063269ms","start":"2026-02-25T19:54:39.481124Z","end":"2026-02-25T19:54:39.621187Z","steps":["trace[1667939317] 'agreement among raft nodes before linearized reading'  (duration: 139.69939ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:54:39.621369Z","caller":"traceutil/trace.go:171","msg":"trace[1012475233] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"166.308593ms","start":"2026-02-25T19:54:39.454982Z","end":"2026-02-25T19:54:39.621291Z","steps":["trace[1012475233] 'process raft request'  (duration: 160.329403ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:54:39.877201Z","caller":"traceutil/trace.go:171","msg":"trace[908391069] linearizableReadLoop","detail":"{readStateIndex:2580; appliedIndex:2579; }","duration":"143.691647ms","start":"2026-02-25T19:54:39.733474Z","end":"2026-02-25T19:54:39.877165Z","steps":["trace[908391069] 'read index received'  (duration: 63.936716ms)","trace[908391069] 'applied index is now lower than readState.Index'  (duration: 79.753761ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:54:39.877283Z","caller":"traceutil/trace.go:171","msg":"trace[721019513] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"144.446337ms","start":"2026-02-25T19:54:39.732814Z","end":"2026-02-25T19:54:39.87726Z","steps":["trace[721019513] 'process raft request'  (duration: 64.668016ms)","trace[721019513] 'compare'  (duration: 79.515394ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:54:39.877545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.053567ms","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-02-25T19:54:39.877615Z","caller":"traceutil/trace.go:171","msg":"trace[1444956331] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2485; }","duration":"144.18387ms","start":"2026-02-25T19:54:39.733417Z","end":"2026-02-25T19:54:39.877601Z","steps":["trace[1444956331] 'agreement among raft nodes before linearized reading'  (duration: 143.885763ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:54:40.210963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.342786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-02-25T19:54:40.211083Z","caller":"traceutil/trace.go:171","msg":"trace[37182468] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2486; }","duration":"156.553472ms","start":"2026-02-25T19:54:40.054504Z","end":"2026-02-25T19:54:40.211057Z","steps":["trace[37182468] 'range keys from in-memory index tree'  (duration: 156.0987ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:43.575764Z","caller":"traceutil/trace.go:171","msg":"trace[101791659] transaction","detail":"{read_only:false; response_revision:4533; number_of_response:1; }","duration":"140.504031ms","start":"2026-02-25T19:58:43.435232Z","end":"2026-02-25T19:58:43.575736Z","steps":["trace[101791659] 'process raft request'  (duration: 140.322346ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:43.721857Z","caller":"traceutil/trace.go:171","msg":"trace[997301363] linearizableReadLoop","detail":"{readStateIndex:4711; appliedIndex:4709; }","duration":"181.974662ms","start":"2026-02-25T19:58:43.539858Z","end":"2026-02-25T19:58:43.721832Z","steps":["trace[997301363] 'read index received'  (duration: 35.737347ms)","trace[997301363] 'applied index is now lower than readState.Index'  (duration: 146.235945ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:58:43.721945Z","caller":"traceutil/trace.go:171","msg":"trace[1118785600] transaction","detail":"{read_only:false; response_revision:4534; number_of_response:1; }","duration":"208.243454ms","start":"2026-02-25T19:58:43.513643Z","end":"2026-02-25T19:58:43.721887Z","steps":["trace[1118785600] 'process raft request'  (duration: 208.021089ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:58:43.722077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.199708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:58:43.722216Z","caller":"traceutil/trace.go:171","msg":"trace[736277560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4534; }","duration":"182.357442ms","start":"2026-02-25T19:58:43.5398Z","end":"2026-02-25T19:58:43.722157Z","steps":["trace[736277560] 'agreement among raft nodes before linearized reading'  (duration: 182.170857ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:58:43.722604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.370314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:714077"}
{"level":"info","ts":"2026-02-25T19:58:43.722662Z","caller":"traceutil/trace.go:171","msg":"trace[1053455132] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4534; }","duration":"163.461256ms","start":"2026-02-25T19:58:43.559187Z","end":"2026-02-25T19:58:43.722648Z","steps":["trace[1053455132] 'agreement among raft nodes before linearized reading'  (duration: 162.804178ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:46.765846Z","caller":"traceutil/trace.go:171","msg":"trace[942316119] linearizableReadLoop","detail":"{readStateIndex:4780; appliedIndex:4779; }","duration":"115.709928ms","start":"2026-02-25T19:58:46.650089Z","end":"2026-02-25T19:58:46.765799Z","steps":["trace[942316119] 'read index received'  (duration: 68.864044ms)","trace[942316119] 'applied index is now lower than readState.Index'  (duration: 46.841234ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:58:46.765927Z","caller":"traceutil/trace.go:171","msg":"trace[883656769] transaction","detail":"{read_only:false; response_revision:4601; number_of_response:1; }","duration":"117.709221ms","start":"2026-02-25T19:58:46.648173Z","end":"2026-02-25T19:58:46.765882Z","steps":["trace[883656769] 'process raft request'  (duration: 70.810266ms)","trace[883656769] 'compare'  (duration: 46.596036ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:58:46.766105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.967706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:58:46.766214Z","caller":"traceutil/trace.go:171","msg":"trace[1985269246] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:0; response_revision:4601; }","duration":"116.15314ms","start":"2026-02-25T19:58:46.650045Z","end":"2026-02-25T19:58:46.766198Z","steps":["trace[1985269246] 'agreement among raft nodes before linearized reading'  (duration: 115.931414ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:46.767767Z","caller":"traceutil/trace.go:171","msg":"trace[1404969920] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"114.020652ms","start":"2026-02-25T19:58:46.653718Z","end":"2026-02-25T19:58:46.767739Z","steps":["trace[1404969920] 'process raft request'  (duration: 113.793626ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:55.312098Z","caller":"traceutil/trace.go:171","msg":"trace[1363155528] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"103.821649ms","start":"2026-02-25T19:58:55.208249Z","end":"2026-02-25T19:58:55.312071Z","steps":["trace[1363155528] 'process raft request'  (duration: 58.922247ms)","trace[1363155528] 'compare'  (duration: 44.590844ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:58:55.312191Z","caller":"traceutil/trace.go:171","msg":"trace[377037587] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"101.699742ms","start":"2026-02-25T19:58:55.210445Z","end":"2026-02-25T19:58:55.312145Z","steps":["trace[377037587] 'process raft request'  (duration: 101.554298ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:55.747089Z","caller":"traceutil/trace.go:171","msg":"trace[1920200034] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"118.303628ms","start":"2026-02-25T19:58:55.628751Z","end":"2026-02-25T19:58:55.747055Z","steps":["trace[1920200034] 'process raft request'  (duration: 117.985269ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:55.747091Z","caller":"traceutil/trace.go:171","msg":"trace[1828298094] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"117.534426ms","start":"2026-02-25T19:58:55.629527Z","end":"2026-02-25T19:58:55.747062Z","steps":["trace[1828298094] 'process raft request'  (duration: 117.426482ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:58:55.74737Z","caller":"traceutil/trace.go:171","msg":"trace[2082028602] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"113.719625ms","start":"2026-02-25T19:58:55.633599Z","end":"2026-02-25T19:58:55.747319Z","steps":["trace[2082028602] 'process raft request'  (duration: 113.417817ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:59:04.254086Z","caller":"traceutil/trace.go:171","msg":"trace[558129960] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"124.899345ms","start":"2026-02-25T19:59:04.129157Z","end":"2026-02-25T19:59:04.254057Z","steps":["trace[558129960] 'process raft request'  (duration: 124.69911ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:59:04.444021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.668148ms","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-02-25T19:59:04.444131Z","caller":"traceutil/trace.go:171","msg":"trace[1801679101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4954; }","duration":"112.843313ms","start":"2026-02-25T19:59:04.331262Z","end":"2026-02-25T19:59:04.444105Z","steps":["trace[1801679101] 'range keys from in-memory index tree'  (duration: 112.466713ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:59:06.899982Z","caller":"traceutil/trace.go:171","msg":"trace[537867904] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"160.002427ms","start":"2026-02-25T19:59:06.739934Z","end":"2026-02-25T19:59:06.899936Z","steps":["trace[537867904] 'process raft request'  (duration: 103.973515ms)","trace[537867904] 'compare'  (duration: 55.838667ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:59:06.900175Z","caller":"traceutil/trace.go:171","msg":"trace[1097016155] linearizableReadLoop","detail":"{readStateIndex:5192; appliedIndex:5189; }","duration":"158.119697ms","start":"2026-02-25T19:59:06.742017Z","end":"2026-02-25T19:59:06.900137Z","steps":["trace[1097016155] 'read index received'  (duration: 3.646428ms)","trace[1097016155] 'applied index is now lower than readState.Index'  (duration: 154.471709ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:59:06.900243Z","caller":"traceutil/trace.go:171","msg":"trace[322650896] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"158.513687ms","start":"2026-02-25T19:59:06.741702Z","end":"2026-02-25T19:59:06.900216Z","steps":["trace[322650896] 'process raft request'  (duration: 158.189259ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:59:06.900499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.471806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-chunks-cache-0\" ","response":"range_response_count:1 size:4463"}
{"level":"info","ts":"2026-02-25T19:59:06.900548Z","caller":"traceutil/trace.go:171","msg":"trace[1112218079] range","detail":"{range_begin:/registry/pods/monitoring/loki-chunks-cache-0; range_end:; response_count:1; response_revision:4999; }","duration":"164.785155ms","start":"2026-02-25T19:59:06.735753Z","end":"2026-02-25T19:59:06.900538Z","steps":["trace[1112218079] 'agreement among raft nodes before linearized reading'  (duration: 164.62726ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:59:06.9005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.301855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-02-25T19:59:06.901482Z","caller":"traceutil/trace.go:171","msg":"trace[995559919] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:4999; }","duration":"139.340772ms","start":"2026-02-25T19:59:06.762123Z","end":"2026-02-25T19:59:06.901464Z","steps":["trace[995559919] 'agreement among raft nodes before linearized reading'  (duration: 138.230473ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:00:44.897509Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2804}
{"level":"info","ts":"2026-02-25T20:00:44.958245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2804,"took":"58.983961ms","hash":3908632316,"current-db-size-bytes":41865216,"current-db-size":"42 MB","current-db-size-in-use-bytes":31330304,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-02-25T20:00:44.958319Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3908632316,"revision":2804,"compact-revision":-1}
{"level":"info","ts":"2026-02-25T20:05:12.600874Z","caller":"traceutil/trace.go:171","msg":"trace[140146722] transaction","detail":"{read_only:false; response_revision:7628; number_of_response:1; }","duration":"112.355123ms","start":"2026-02-25T20:05:12.488483Z","end":"2026-02-25T20:05:12.600838Z","steps":["trace[140146722] 'process raft request'  (duration: 112.126707ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:05:23.925687Z","caller":"traceutil/trace.go:171","msg":"trace[851913921] transaction","detail":"{read_only:false; response_revision:7679; number_of_response:1; }","duration":"183.824665ms","start":"2026-02-25T20:05:23.74183Z","end":"2026-02-25T20:05:23.925655Z","steps":["trace[851913921] 'process raft request'  (duration: 183.336542ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:05:44.904269Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5811}
{"level":"info","ts":"2026-02-25T20:05:44.995048Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5811,"took":"88.95088ms","hash":1751162968,"current-db-size-bytes":43151360,"current-db-size":"43 MB","current-db-size-in-use-bytes":22839296,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-02-25T20:05:44.995105Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1751162968,"revision":5811,"compact-revision":2804}
{"level":"warn","ts":"2026-02-25T20:06:05.581085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.815792ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555424561 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/ingress/openstack/rook-ceph-cluster\" mod_revision:7919 > success:<request_put:<key:\"/registry/ingress/openstack/rook-ceph-cluster\" value_size:1044 >> failure:<request_range:<key:\"/registry/ingress/openstack/rook-ceph-cluster\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T20:06:05.581407Z","caller":"traceutil/trace.go:171","msg":"trace[1720962914] transaction","detail":"{read_only:false; response_revision:7978; number_of_response:1; }","duration":"225.925428ms","start":"2026-02-25T20:06:05.355467Z","end":"2026-02-25T20:06:05.581392Z","steps":["trace[1720962914] 'process raft request'  (duration: 225.789025ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:06:05.581388Z","caller":"traceutil/trace.go:171","msg":"trace[687744191] transaction","detail":"{read_only:false; response_revision:7977; number_of_response:1; }","duration":"226.093082ms","start":"2026-02-25T20:06:05.355259Z","end":"2026-02-25T20:06:05.581352Z","steps":["trace[687744191] 'process raft request'  (duration: 97.86977ms)","trace[687744191] 'compare'  (duration: 127.490263ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:06:05.581452Z","caller":"traceutil/trace.go:171","msg":"trace[1992886845] linearizableReadLoop","detail":"{readStateIndex:8273; appliedIndex:8272; }","duration":"225.929739ms","start":"2026-02-25T20:06:05.355474Z","end":"2026-02-25T20:06:05.581403Z","steps":["trace[1992886845] 'read index received'  (duration: 97.784158ms)","trace[1992886845] 'applied index is now lower than readState.Index'  (duration: 128.142381ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:06:05.581664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.173335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T20:06:05.581775Z","caller":"traceutil/trace.go:171","msg":"trace[239406443] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:7978; }","duration":"226.35296ms","start":"2026-02-25T20:06:05.355398Z","end":"2026-02-25T20:06:05.581751Z","steps":["trace[239406443] 'agreement among raft nodes before linearized reading'  (duration: 226.169635ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:06:05.581767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.836986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T20:06:05.581863Z","caller":"traceutil/trace.go:171","msg":"trace[1202002593] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:7978; }","duration":"225.99627ms","start":"2026-02-25T20:06:05.355843Z","end":"2026-02-25T20:06:05.58184Z","steps":["trace[1202002593] 'agreement among raft nodes before linearized reading'  (duration: 225.805585ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:06:05.765011Z","caller":"traceutil/trace.go:171","msg":"trace[186502048] transaction","detail":"{read_only:false; response_revision:7980; number_of_response:1; }","duration":"101.007884ms","start":"2026-02-25T20:06:05.663973Z","end":"2026-02-25T20:06:05.764981Z","steps":["trace[186502048] 'process raft request'  (duration: 100.823539ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:06:06.556654Z","caller":"traceutil/trace.go:171","msg":"trace[149728436] linearizableReadLoop","detail":"{readStateIndex:8287; appliedIndex:8285; }","duration":"170.106924ms","start":"2026-02-25T20:06:06.386522Z","end":"2026-02-25T20:06:06.556629Z","steps":["trace[149728436] 'read index received'  (duration: 17.743676ms)","trace[149728436] 'applied index is now lower than readState.Index'  (duration: 152.362308ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:06:06.556821Z","caller":"traceutil/trace.go:171","msg":"trace[1229522989] transaction","detail":"{read_only:false; response_revision:7991; number_of_response:1; }","duration":"176.097624ms","start":"2026-02-25T20:06:06.380589Z","end":"2026-02-25T20:06:06.556686Z","steps":["trace[1229522989] 'process raft request'  (duration: 159.354976ms)","trace[1229522989] 'compare'  (duration: 16.562763ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:06:06.557219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.505264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"}
{"level":"info","ts":"2026-02-25T20:06:06.557351Z","caller":"traceutil/trace.go:171","msg":"trace[262147195] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:7991; }","duration":"170.842354ms","start":"2026-02-25T20:06:06.386484Z","end":"2026-02-25T20:06:06.557327Z","steps":["trace[262147195] 'agreement among raft nodes before linearized reading'  (duration: 170.388112ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:07:12.170218Z","caller":"traceutil/trace.go:171","msg":"trace[691781482] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"164.479973ms","start":"2026-02-25T20:07:12.005702Z","end":"2026-02-25T20:07:12.170182Z","steps":["trace[691781482] 'process raft request'  (duration: 164.159395ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:07:24.663383Z","caller":"traceutil/trace.go:171","msg":"trace[1304223560] linearizableReadLoop","detail":"{readStateIndex:9021; appliedIndex:9020; }","duration":"123.662192ms","start":"2026-02-25T20:07:24.539694Z","end":"2026-02-25T20:07:24.663356Z","steps":["trace[1304223560] 'read index received'  (duration: 123.541277ms)","trace[1304223560] 'applied index is now lower than readState.Index'  (duration: 119.515µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:07:24.66345Z","caller":"traceutil/trace.go:171","msg":"trace[392590767] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"152.706719ms","start":"2026-02-25T20:07:24.510719Z","end":"2026-02-25T20:07:24.663426Z","steps":["trace[392590767] 'process raft request'  (duration: 152.436961ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:07:24.663552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.837187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T20:07:24.663638Z","caller":"traceutil/trace.go:171","msg":"trace[1604321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8704; }","duration":"123.996161ms","start":"2026-02-25T20:07:24.539628Z","end":"2026-02-25T20:07:24.663625Z","steps":["trace[1604321] 'agreement among raft nodes before linearized reading'  (duration: 123.856487ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:10:01.311835Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-02-25T20:10:01.32084Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-02-25T20:10:01.321037Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-02-25T20:10:44.911948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7786}
{"level":"info","ts":"2026-02-25T20:10:44.977897Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7786,"took":"63.603238ms","hash":3481728367,"current-db-size-bytes":43151360,"current-db-size":"43 MB","current-db-size-in-use-bytes":24432640,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-02-25T20:10:44.977966Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3481728367,"revision":7786,"compact-revision":5811}
{"level":"warn","ts":"2026-02-25T20:13:04.310318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.478599ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555432902 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:10985 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T20:13:04.310776Z","caller":"traceutil/trace.go:171","msg":"trace[1717650862] linearizableReadLoop","detail":"{readStateIndex:11391; appliedIndex:11388; }","duration":"227.236315ms","start":"2026-02-25T20:13:04.083355Z","end":"2026-02-25T20:13:04.310591Z","steps":["trace[1717650862] 'read index received'  (duration: 13.299429ms)","trace[1717650862] 'applied index is now lower than readState.Index'  (duration: 213.935506ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:13:04.310747Z","caller":"traceutil/trace.go:171","msg":"trace[2017918072] transaction","detail":"{read_only:false; response_revision:10994; number_of_response:1; }","duration":"268.260433ms","start":"2026-02-25T20:13:04.042401Z","end":"2026-02-25T20:13:04.310661Z","steps":["trace[2017918072] 'process raft request'  (duration: 268.074098ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:13:04.310915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.516072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T20:13:04.310997Z","caller":"traceutil/trace.go:171","msg":"trace[1856333728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10994; }","duration":"227.656626ms","start":"2026-02-25T20:13:04.083322Z","end":"2026-02-25T20:13:04.310978Z","steps":["trace[1856333728] 'agreement among raft nodes before linearized reading'  (duration: 227.388809ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:13:04.311121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.164248ms","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-02-25T20:13:04.311211Z","caller":"traceutil/trace.go:171","msg":"trace[946588284] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10994; }","duration":"199.327402ms","start":"2026-02-25T20:13:04.11186Z","end":"2026-02-25T20:13:04.311187Z","steps":["trace[946588284] 'agreement among raft nodes before linearized reading'  (duration: 199.041924ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:13:04.311517Z","caller":"traceutil/trace.go:171","msg":"trace[1576247132] transaction","detail":"{read_only:false; response_revision:10993; number_of_response:1; }","duration":"270.711518ms","start":"2026-02-25T20:13:04.040691Z","end":"2026-02-25T20:13:04.311402Z","steps":["trace[1576247132] 'process raft request'  (duration: 161.017657ms)","trace[1576247132] 'compare'  (duration: 108.13724ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:13:04.832251Z","caller":"traceutil/trace.go:171","msg":"trace[803695715] transaction","detail":"{read_only:false; response_revision:10997; number_of_response:1; }","duration":"174.207864ms","start":"2026-02-25T20:13:04.658015Z","end":"2026-02-25T20:13:04.832223Z","steps":["trace[803695715] 'process raft request'  (duration: 174.039969ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:15:44.921083Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9852}
{"level":"info","ts":"2026-02-25T20:15:45.004879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9852,"took":"80.077012ms","hash":2955676176,"current-db-size-bytes":43151360,"current-db-size":"43 MB","current-db-size-in-use-bytes":22945792,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-02-25T20:15:45.004937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2955676176,"revision":9852,"compact-revision":7786}
{"level":"info","ts":"2026-02-25T20:17:45.561366Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000033c2.wal"}
{"level":"info","ts":"2026-02-25T20:19:39.096037Z","caller":"traceutil/trace.go:171","msg":"trace[576325021] transaction","detail":"{read_only:false; response_revision:13438; number_of_response:1; }","duration":"101.360656ms","start":"2026-02-25T20:19:38.994638Z","end":"2026-02-25T20:19:39.095998Z","steps":["trace[576325021] 'process raft request'  (duration: 100.997346ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:19:39.30182Z","caller":"traceutil/trace.go:171","msg":"trace[605903397] linearizableReadLoop","detail":"{readStateIndex:13930; appliedIndex:13929; }","duration":"196.076252ms","start":"2026-02-25T20:19:39.105709Z","end":"2026-02-25T20:19:39.301786Z","steps":["trace[605903397] 'read index received'  (duration: 173.011328ms)","trace[605903397] 'applied index is now lower than readState.Index'  (duration: 23.063613ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:19:39.30197Z","caller":"traceutil/trace.go:171","msg":"trace[716968947] transaction","detail":"{read_only:false; response_revision:13439; number_of_response:1; }","duration":"200.881671ms","start":"2026-02-25T20:19:39.101075Z","end":"2026-02-25T20:19:39.301956Z","steps":["trace[716968947] 'process raft request'  (duration: 177.649373ms)","trace[716968947] 'compare'  (duration: 22.93869ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:19:39.302156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.921668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4n9gk\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-02-25T20:19:39.302262Z","caller":"traceutil/trace.go:171","msg":"trace[860769098] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4n9gk; range_end:; response_count:1; response_revision:13439; }","duration":"179.086463ms","start":"2026-02-25T20:19:39.12315Z","end":"2026-02-25T20:19:39.302237Z","steps":["trace[860769098] 'agreement among raft nodes before linearized reading'  (duration: 178.817825ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:19:39.30237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.644906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T20:19:39.302429Z","caller":"traceutil/trace.go:171","msg":"trace[474466932] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:13439; }","duration":"196.77511ms","start":"2026-02-25T20:19:39.105636Z","end":"2026-02-25T20:19:39.302411Z","steps":["trace[474466932] 'agreement among raft nodes before linearized reading'  (duration: 196.662867ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:19:39.302558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.749844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T20:19:39.302695Z","caller":"traceutil/trace.go:171","msg":"trace[345640236] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:13439; }","duration":"158.978681ms","start":"2026-02-25T20:19:39.143688Z","end":"2026-02-25T20:19:39.302666Z","steps":["trace[345640236] 'agreement among raft nodes before linearized reading'  (duration: 158.683483ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:20:44.927345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11990}
{"level":"info","ts":"2026-02-25T20:20:45.005911Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11990,"took":"75.226918ms","hash":2050516781,"current-db-size-bytes":43151360,"current-db-size":"43 MB","current-db-size-in-use-bytes":27131904,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-02-25T20:20:45.005979Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2050516781,"revision":11990,"compact-revision":9852}
{"level":"info","ts":"2026-02-25T20:21:28.144919Z","caller":"traceutil/trace.go:171","msg":"trace[1154127376] transaction","detail":"{read_only:false; response_revision:14510; number_of_response:1; }","duration":"143.079977ms","start":"2026-02-25T20:21:28.001792Z","end":"2026-02-25T20:21:28.144872Z","steps":["trace[1154127376] 'process raft request'  (duration: 142.753738ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:25:44.934809Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14282}
{"level":"info","ts":"2026-02-25T20:25:45.035063Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14282,"took":"96.764024ms","hash":957505725,"current-db-size-bytes":43151360,"current-db-size":"43 MB","current-db-size-in-use-bytes":27701248,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-02-25T20:25:45.035148Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":957505725,"revision":14282,"compact-revision":11990}
{"level":"info","ts":"2026-02-25T20:30:44.942559Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16347}
{"level":"info","ts":"2026-02-25T20:30:45.045658Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16347,"took":"97.883624ms","hash":998585105,"current-db-size-bytes":43151360,"current-db-size":"43 MB","current-db-size-in-use-bytes":28999680,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-02-25T20:30:45.045739Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":998585105,"revision":16347,"compact-revision":14282}
{"level":"warn","ts":"2026-02-25T20:32:53.954029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.654637ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555460733 > lease_revoke:<id:664b9c965a94e99a>","response":"size:30"}
{"level":"info","ts":"2026-02-25T20:33:00.854824Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-02-25T20:33:00.860611Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-02-25T20:33:00.86069Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-02-25T20:33:10.226031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.102936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-25T20:33:10.226144Z","caller":"traceutil/trace.go:171","msg":"trace[1698238563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19345; }","duration":"148.306541ms","start":"2026-02-25T20:33:10.077814Z","end":"2026-02-25T20:33:10.22612Z","steps":["trace[1698238563] 'range keys from in-memory index tree'  (duration: 147.807938ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:33:10.227368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.518647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-02-25T20:33:10.227524Z","caller":"traceutil/trace.go:171","msg":"trace[389947594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19345; }","duration":"158.66359ms","start":"2026-02-25T20:33:10.068805Z","end":"2026-02-25T20:33:10.227468Z","steps":["trace[389947594] 'range keys from in-memory index tree'  (duration: 157.333965ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:33:10.478374Z","caller":"traceutil/trace.go:171","msg":"trace[93732156] transaction","detail":"{read_only:false; response_revision:19347; number_of_response:1; }","duration":"241.305265ms","start":"2026-02-25T20:33:10.237026Z","end":"2026-02-25T20:33:10.478331Z","steps":["trace[93732156] 'process raft request'  (duration: 164.394505ms)","trace[93732156] 'compare'  (duration: 76.702374ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:33:10.478718Z","caller":"traceutil/trace.go:171","msg":"trace[500310310] linearizableReadLoop","detail":"{readStateIndex:20051; appliedIndex:20049; }","duration":"239.24757ms","start":"2026-02-25T20:33:10.239422Z","end":"2026-02-25T20:33:10.478669Z","steps":["trace[500310310] 'read index received'  (duration: 83.925189ms)","trace[500310310] 'applied index is now lower than readState.Index'  (duration: 155.319591ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:33:10.47877Z","caller":"traceutil/trace.go:171","msg":"trace[210122346] transaction","detail":"{read_only:false; response_revision:19348; number_of_response:1; }","duration":"169.284577ms","start":"2026-02-25T20:33:10.309435Z","end":"2026-02-25T20:33:10.47872Z","steps":["trace[210122346] 'process raft request'  (duration: 168.837644ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:33:10.480132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.681507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:109 size:1097302"}
{"level":"info","ts":"2026-02-25T20:33:10.480188Z","caller":"traceutil/trace.go:171","msg":"trace[523416630] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:109; response_revision:19348; }","duration":"240.784571ms","start":"2026-02-25T20:33:10.239388Z","end":"2026-02-25T20:33:10.480173Z","steps":["trace[523416630] 'agreement among raft nodes before linearized reading'  (duration: 239.433315ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:35:44.952637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18387}
{"level":"info","ts":"2026-02-25T20:35:45.058286Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18387,"took":"100.895365ms","hash":2148751233,"current-db-size-bytes":44437504,"current-db-size":"44 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-02-25T20:35:45.05836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2148751233,"revision":18387,"compact-revision":16347}
{"level":"info","ts":"2026-02-25T20:37:01.689897Z","caller":"traceutil/trace.go:171","msg":"trace[2003969561] transaction","detail":"{read_only:false; response_revision:21668; number_of_response:1; }","duration":"125.175529ms","start":"2026-02-25T20:37:01.564685Z","end":"2026-02-25T20:37:01.689861Z","steps":["trace[2003969561] 'process raft request'  (duration: 124.908742ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:37:01.852141Z","caller":"traceutil/trace.go:171","msg":"trace[1461341242] transaction","detail":"{read_only:false; response_revision:21670; number_of_response:1; }","duration":"145.503516ms","start":"2026-02-25T20:37:01.706606Z","end":"2026-02-25T20:37:01.85211Z","steps":["trace[1461341242] 'process raft request'  (duration: 145.352822ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:37:01.85238Z","caller":"traceutil/trace.go:171","msg":"trace[1716485316] linearizableReadLoop","detail":"{readStateIndex:22445; appliedIndex:22443; }","duration":"218.860841ms","start":"2026-02-25T20:37:01.63351Z","end":"2026-02-25T20:37:01.852371Z","steps":["trace[1716485316] 'read index received'  (duration: 56.120181ms)","trace[1716485316] 'applied index is now lower than readState.Index'  (duration: 162.73928ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:37:01.852657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.129118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T20:37:01.852718Z","caller":"traceutil/trace.go:171","msg":"trace[1963803785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21670; }","duration":"219.265831ms","start":"2026-02-25T20:37:01.633442Z","end":"2026-02-25T20:37:01.852708Z","steps":["trace[1963803785] 'agreement among raft nodes before linearized reading'  (duration: 218.974763ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:37:01.852727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.414465ms","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-02-25T20:37:01.852758Z","caller":"traceutil/trace.go:171","msg":"trace[1549745244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21670; }","duration":"148.520597ms","start":"2026-02-25T20:37:01.704229Z","end":"2026-02-25T20:37:01.85275Z","steps":["trace[1549745244] 'agreement among raft nodes before linearized reading'  (duration: 148.334502ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:37:01.852211Z","caller":"traceutil/trace.go:171","msg":"trace[151027172] transaction","detail":"{read_only:false; response_revision:21669; number_of_response:1; }","duration":"247.80423ms","start":"2026-02-25T20:37:01.604368Z","end":"2026-02-25T20:37:01.852172Z","steps":["trace[151027172] 'process raft request'  (duration: 234.223064ms)","trace[151027172] 'compare'  (duration: 12.860057ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:27.083506Z","caller":"traceutil/trace.go:171","msg":"trace[826058893] transaction","detail":"{read_only:false; response_revision:23636; number_of_response:1; }","duration":"393.132881ms","start":"2026-02-25T20:40:26.69035Z","end":"2026-02-25T20:40:27.083483Z","steps":["trace[826058893] 'process raft request'  (duration: 392.969626ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.083672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:26.69033Z","time spent":"393.264725ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23622 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-02-25T20:40:27.467297Z","caller":"traceutil/trace.go:171","msg":"trace[917383786] transaction","detail":"{read_only:false; response_revision:23637; number_of_response:1; }","duration":"675.563129ms","start":"2026-02-25T20:40:26.791705Z","end":"2026-02-25T20:40:27.467268Z","steps":["trace[917383786] 'process raft request'  (duration: 675.318833ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.467497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:26.79167Z","time spent":"675.718063ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:23623 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-02-25T20:40:27.467888Z","caller":"traceutil/trace.go:171","msg":"trace[588370634] linearizableReadLoop","detail":"{readStateIndex:24466; appliedIndex:24463; }","duration":"591.133125ms","start":"2026-02-25T20:40:26.876713Z","end":"2026-02-25T20:40:27.467846Z","steps":["trace[588370634] 'read index received'  (duration: 206.567415ms)","trace[588370634] 'applied index is now lower than readState.Index'  (duration: 384.56405ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:27.467928Z","caller":"traceutil/trace.go:171","msg":"trace[553770368] transaction","detail":"{read_only:false; response_revision:23639; number_of_response:1; }","duration":"447.520126ms","start":"2026-02-25T20:40:27.020374Z","end":"2026-02-25T20:40:27.467894Z","steps":["trace[553770368] 'process raft request'  (duration: 447.136556ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:27.468004Z","caller":"traceutil/trace.go:171","msg":"trace[1675069927] transaction","detail":"{read_only:false; response_revision:23638; number_of_response:1; }","duration":"670.845462ms","start":"2026-02-25T20:40:26.797143Z","end":"2026-02-25T20:40:27.467989Z","steps":["trace[1675069927] 'process raft request'  (duration: 670.079831ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:27.468077Z","caller":"traceutil/trace.go:171","msg":"trace[780755043] transaction","detail":"{read_only:false; response_revision:23640; number_of_response:1; }","duration":"404.593229ms","start":"2026-02-25T20:40:27.063467Z","end":"2026-02-25T20:40:27.46806Z","steps":["trace[780755043] 'process raft request'  (duration: 404.26185ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.468091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:26.797127Z","time spent":"670.925453ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:23624 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:27.468139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.02035Z","time spent":"447.67773ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23627 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:27.468245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.063437Z","time spent":"404.686021ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23628 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-02-25T20:40:27.468517Z","caller":"traceutil/trace.go:171","msg":"trace[540824797] transaction","detail":"{read_only:false; response_revision:23641; number_of_response:1; }","duration":"402.978926ms","start":"2026-02-25T20:40:27.065512Z","end":"2026-02-25T20:40:27.46849Z","steps":["trace[540824797] 'process raft request'  (duration: 402.272787ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.46863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.254225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T20:40:27.468691Z","caller":"traceutil/trace.go:171","msg":"trace[1113001186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23641; }","duration":"474.349348ms","start":"2026-02-25T20:40:26.994326Z","end":"2026-02-25T20:40:27.468676Z","steps":["trace[1113001186] 'agreement among raft nodes before linearized reading'  (duration: 474.199144ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.468728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:26.994306Z","time spent":"474.41448ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T20:40:27.468908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.187353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"warn","ts":"2026-02-25T20:40:27.468952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.362273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" ","response":"range_response_count:1 size:22018"}
{"level":"info","ts":"2026-02-25T20:40:27.468976Z","caller":"traceutil/trace.go:171","msg":"trace[58618548] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23641; }","duration":"592.302345ms","start":"2026-02-25T20:40:26.876657Z","end":"2026-02-25T20:40:27.46896Z","steps":["trace[58618548] 'agreement among raft nodes before linearized reading'  (duration: 592.060639ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.469036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:26.876631Z","time spent":"592.394278ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9733,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" "}
{"level":"warn","ts":"2026-02-25T20:40:27.469053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.148479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:27.469086Z","caller":"traceutil/trace.go:171","msg":"trace[719781030] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:23641; }","duration":"361.22259ms","start":"2026-02-25T20:40:27.107852Z","end":"2026-02-25T20:40:27.469075Z","steps":["trace[719781030] 'agreement among raft nodes before linearized reading'  (duration: 361.160529ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.469128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.107834Z","time spent":"361.281343ms","remote":"127.0.0.1:48374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T20:40:27.468618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.065481Z","time spent":"403.086539ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:23629 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:27.469318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.445733ms","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-02-25T20:40:27.469365Z","caller":"traceutil/trace.go:171","msg":"trace[2114780079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23641; }","duration":"470.552715ms","start":"2026-02-25T20:40:26.9988Z","end":"2026-02-25T20:40:27.469353Z","steps":["trace[2114780079] 'agreement among raft nodes before linearized reading'  (duration: 470.452302ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:27.468988Z","caller":"traceutil/trace.go:171","msg":"trace[1673916027] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-lsg6c; range_end:; response_count:1; response_revision:23641; }","duration":"283.396124ms","start":"2026-02-25T20:40:27.18558Z","end":"2026-02-25T20:40:27.468976Z","steps":["trace[1673916027] 'agreement among raft nodes before linearized reading'  (duration: 283.26629ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.469404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:26.998763Z","time spent":"470.633228ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T20:40:27.837416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.95705ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555473426 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:23626 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:27.837687Z","caller":"traceutil/trace.go:171","msg":"trace[705568864] transaction","detail":"{read_only:false; response_revision:23644; number_of_response:1; }","duration":"361.122179ms","start":"2026-02-25T20:40:27.476545Z","end":"2026-02-25T20:40:27.837667Z","steps":["trace[705568864] 'process raft request'  (duration: 361.039917ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.837766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.47654Z","time spent":"361.193021ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:23625 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T20:40:27.837803Z","caller":"traceutil/trace.go:171","msg":"trace[47511879] transaction","detail":"{read_only:false; response_revision:23642; number_of_response:1; }","duration":"362.204267ms","start":"2026-02-25T20:40:27.475554Z","end":"2026-02-25T20:40:27.837758Z","steps":["trace[47511879] 'process raft request'  (duration: 87.803715ms)","trace[47511879] 'compare'  (duration: 273.825877ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:27.837991Z","caller":"traceutil/trace.go:171","msg":"trace[799444602] transaction","detail":"{read_only:false; response_revision:23643; number_of_response:1; }","duration":"361.425917ms","start":"2026-02-25T20:40:27.47647Z","end":"2026-02-25T20:40:27.837896Z","steps":["trace[799444602] 'process raft request'  (duration: 361.054557ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:27.838177Z","caller":"traceutil/trace.go:171","msg":"trace[1300354728] linearizableReadLoop","detail":"{readStateIndex:24473; appliedIndex:24469; }","duration":"358.820966ms","start":"2026-02-25T20:40:27.479349Z","end":"2026-02-25T20:40:27.83817Z","steps":["trace[1300354728] 'read index received'  (duration: 84.051364ms)","trace[1300354728] 'applied index is now lower than readState.Index'  (duration: 274.768742ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:27.83804Z","caller":"traceutil/trace.go:171","msg":"trace[1162717083] transaction","detail":"{read_only:false; response_revision:23645; number_of_response:1; }","duration":"359.859184ms","start":"2026-02-25T20:40:27.478165Z","end":"2026-02-25T20:40:27.838024Z","steps":["trace[1162717083] 'process raft request'  (duration: 359.459334ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.838224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.476443Z","time spent":"361.657133ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23633 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:27.838267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.478158Z","time spent":"360.07238ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:23631 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:27.838037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.475535Z","time spent":"362.371882ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:23626 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T20:40:27.838248Z","caller":"traceutil/trace.go:171","msg":"trace[654802984] transaction","detail":"{read_only:false; response_revision:23646; number_of_response:1; }","duration":"282.456429ms","start":"2026-02-25T20:40:27.555786Z","end":"2026-02-25T20:40:27.838242Z","steps":["trace[654802984] 'process raft request'  (duration: 282.159521ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.838696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.893173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:27.838748Z","caller":"traceutil/trace.go:171","msg":"trace[253606033] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:23646; }","duration":"243.1767ms","start":"2026-02-25T20:40:27.595557Z","end":"2026-02-25T20:40:27.838733Z","steps":["trace[253606033] 'agreement among raft nodes before linearized reading'  (duration: 242.895373ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.839364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.01244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:134 size:1314294"}
{"level":"info","ts":"2026-02-25T20:40:27.839394Z","caller":"traceutil/trace.go:171","msg":"trace[1012069484] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:134; response_revision:23646; }","duration":"360.06557ms","start":"2026-02-25T20:40:27.479322Z","end":"2026-02-25T20:40:27.839387Z","steps":["trace[1012069484] 'agreement among raft nodes before linearized reading'  (duration: 358.93837ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:27.839414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.479305Z","time spent":"360.103442ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":134,"response size":1314318,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-02-25T20:40:28.367095Z","caller":"traceutil/trace.go:171","msg":"trace[1335063601] transaction","detail":"{read_only:false; response_revision:23647; number_of_response:1; }","duration":"467.015201ms","start":"2026-02-25T20:40:27.900044Z","end":"2026-02-25T20:40:28.367059Z","steps":["trace[1335063601] 'process raft request'  (duration: 466.816056ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:28.367281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:27.900027Z","time spent":"467.158415ms","remote":"127.0.0.1:34100","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:23635 > 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-02-25T20:40:28.378265Z","caller":"traceutil/trace.go:171","msg":"trace[338900578] linearizableReadLoop","detail":"{readStateIndex:24476; appliedIndex:24474; }","duration":"206.418131ms","start":"2026-02-25T20:40:28.171819Z","end":"2026-02-25T20:40:28.378237Z","steps":["trace[338900578] 'read index received'  (duration: 195.019444ms)","trace[338900578] 'applied index is now lower than readState.Index'  (duration: 11.395027ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:28.378416Z","caller":"traceutil/trace.go:171","msg":"trace[614674446] transaction","detail":"{read_only:false; response_revision:23648; number_of_response:1; }","duration":"372.257069ms","start":"2026-02-25T20:40:28.006116Z","end":"2026-02-25T20:40:28.378373Z","steps":["trace[614674446] 'process raft request'  (duration: 371.960811ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:28.378508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.656167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-02-25T20:40:28.378545Z","caller":"traceutil/trace.go:171","msg":"trace[74758932] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:23648; }","duration":"206.781621ms","start":"2026-02-25T20:40:28.171752Z","end":"2026-02-25T20:40:28.378534Z","steps":["trace[74758932] 'agreement among raft nodes before linearized reading'  (duration: 206.601206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:28.378679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:28.00601Z","time spent":"372.511456ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:23547 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:28.696952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.762243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:28.697048Z","caller":"traceutil/trace.go:171","msg":"trace[2023695139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23649; }","duration":"156.939127ms","start":"2026-02-25T20:40:28.540089Z","end":"2026-02-25T20:40:28.697028Z","steps":["trace[2023695139] 'range keys from in-memory index tree'  (duration: 156.64938ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:35.434151Z","caller":"traceutil/trace.go:171","msg":"trace[1450082541] transaction","detail":"{read_only:false; response_revision:23690; number_of_response:1; }","duration":"322.160859ms","start":"2026-02-25T20:40:35.111962Z","end":"2026-02-25T20:40:35.434123Z","steps":["trace[1450082541] 'process raft request'  (duration: 322.005015ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:35.434338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:35.111934Z","time spent":"322.315402ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23678 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-02-25T20:40:35.553273Z","caller":"traceutil/trace.go:171","msg":"trace[597144173] transaction","detail":"{read_only:false; response_revision:23691; number_of_response:1; }","duration":"123.841086ms","start":"2026-02-25T20:40:35.429398Z","end":"2026-02-25T20:40:35.553239Z","steps":["trace[597144173] 'process raft request'  (duration: 58.887267ms)","trace[597144173] 'compare'  (duration: 64.768444ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:35.632491Z","caller":"traceutil/trace.go:171","msg":"trace[289041559] transaction","detail":"{read_only:false; response_revision:23692; number_of_response:1; }","duration":"123.954729ms","start":"2026-02-25T20:40:35.508503Z","end":"2026-02-25T20:40:35.632458Z","steps":["trace[289041559] 'process raft request'  (duration: 123.805395ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:35.772433Z","caller":"traceutil/trace.go:171","msg":"trace[1901820082] transaction","detail":"{read_only:false; response_revision:23694; number_of_response:1; }","duration":"262.905202ms","start":"2026-02-25T20:40:35.50949Z","end":"2026-02-25T20:40:35.772396Z","steps":["trace[1901820082] 'process raft request'  (duration: 262.719257ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:35.772733Z","caller":"traceutil/trace.go:171","msg":"trace[699924912] transaction","detail":"{read_only:false; response_revision:23693; number_of_response:1; }","duration":"263.605782ms","start":"2026-02-25T20:40:35.509071Z","end":"2026-02-25T20:40:35.772677Z","steps":["trace[699924912] 'process raft request'  (duration: 262.699628ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:35.772902Z","caller":"traceutil/trace.go:171","msg":"trace[1596088153] linearizableReadLoop","detail":"{readStateIndex:24526; appliedIndex:24521; }","duration":"219.677539ms","start":"2026-02-25T20:40:35.553198Z","end":"2026-02-25T20:40:35.772876Z","steps":["trace[1596088153] 'read index received'  (duration: 79.190093ms)","trace[1596088153] 'applied index is now lower than readState.Index'  (duration: 140.485836ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:35.77293Z","caller":"traceutil/trace.go:171","msg":"trace[824039302] transaction","detail":"{read_only:false; response_revision:23696; number_of_response:1; }","duration":"262.76542ms","start":"2026-02-25T20:40:35.510135Z","end":"2026-02-25T20:40:35.7729Z","steps":["trace[824039302] 'process raft request'  (duration: 262.635496ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:35.772959Z","caller":"traceutil/trace.go:171","msg":"trace[799022384] transaction","detail":"{read_only:false; response_revision:23695; number_of_response:1; }","duration":"263.326664ms","start":"2026-02-25T20:40:35.509578Z","end":"2026-02-25T20:40:35.772905Z","steps":["trace[799022384] 'process raft request'  (duration: 262.765688ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:35.77322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.290755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"info","ts":"2026-02-25T20:40:35.773269Z","caller":"traceutil/trace.go:171","msg":"trace[1081791553] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23696; }","duration":"197.415759ms","start":"2026-02-25T20:40:35.575842Z","end":"2026-02-25T20:40:35.773257Z","steps":["trace[1081791553] 'agreement among raft nodes before linearized reading'  (duration: 197.203873ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:35.77333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.732433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:35.773428Z","caller":"traceutil/trace.go:171","msg":"trace[348430585] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:23696; }","duration":"245.059182ms","start":"2026-02-25T20:40:35.528346Z","end":"2026-02-25T20:40:35.773405Z","steps":["trace[348430585] 'agreement among raft nodes before linearized reading'  (duration: 244.61789ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.120149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.798299ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555473586 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:23684 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:36.120304Z","caller":"traceutil/trace.go:171","msg":"trace[863754445] linearizableReadLoop","detail":"{readStateIndex:24527; appliedIndex:24526; }","duration":"242.828791ms","start":"2026-02-25T20:40:35.877451Z","end":"2026-02-25T20:40:36.12028Z","steps":["trace[863754445] 'read index received'  (duration: 133.822805ms)","trace[863754445] 'applied index is now lower than readState.Index'  (duration: 109.004276ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:36.120613Z","caller":"traceutil/trace.go:171","msg":"trace[1938184214] transaction","detail":"{read_only:false; response_revision:23697; number_of_response:1; }","duration":"248.142745ms","start":"2026-02-25T20:40:35.872455Z","end":"2026-02-25T20:40:36.120597Z","steps":["trace[1938184214] 'process raft request'  (duration: 138.763199ms)","trace[1938184214] 'compare'  (duration: 108.639705ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:36.120974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.51464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T20:40:36.121019Z","caller":"traceutil/trace.go:171","msg":"trace[2143146454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23697; }","duration":"243.588322ms","start":"2026-02-25T20:40:35.877417Z","end":"2026-02-25T20:40:36.121005Z","steps":["trace[2143146454] 'agreement among raft nodes before linearized reading'  (duration: 243.420077ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.121292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.689594ms","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-02-25T20:40:36.121347Z","caller":"traceutil/trace.go:171","msg":"trace[692571840] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23697; }","duration":"243.776536ms","start":"2026-02-25T20:40:35.877557Z","end":"2026-02-25T20:40:36.121333Z","steps":["trace[692571840] 'agreement among raft nodes before linearized reading'  (duration: 243.619252ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.121695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.515405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" ","response":"range_response_count:1 size:22018"}
{"level":"info","ts":"2026-02-25T20:40:36.121738Z","caller":"traceutil/trace.go:171","msg":"trace[516102503] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-lsg6c; range_end:; response_count:1; response_revision:23697; }","duration":"176.582387ms","start":"2026-02-25T20:40:35.945144Z","end":"2026-02-25T20:40:36.121726Z","steps":["trace[516102503] 'agreement among raft nodes before linearized reading'  (duration: 176.450083ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.121975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.815003ms","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-02-25T20:40:36.122018Z","caller":"traceutil/trace.go:171","msg":"trace[1445529252] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23697; }","duration":"241.870075ms","start":"2026-02-25T20:40:35.880138Z","end":"2026-02-25T20:40:36.122008Z","steps":["trace[1445529252] 'agreement among raft nodes before linearized reading'  (duration: 241.772663ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.122214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.192508ms","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-02-25T20:40:36.122254Z","caller":"traceutil/trace.go:171","msg":"trace[62711757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23697; }","duration":"244.27396ms","start":"2026-02-25T20:40:35.877969Z","end":"2026-02-25T20:40:36.122243Z","steps":["trace[62711757] 'agreement among raft nodes before linearized reading'  (duration: 244.185737ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.397425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.07639ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555473589 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:23687 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:36.397521Z","caller":"traceutil/trace.go:171","msg":"trace[1384160351] transaction","detail":"{read_only:false; response_revision:23698; number_of_response:1; }","duration":"260.302133ms","start":"2026-02-25T20:40:36.137197Z","end":"2026-02-25T20:40:36.397499Z","steps":["trace[1384160351] 'process raft request'  (duration: 122.085369ms)","trace[1384160351] 'compare'  (duration: 137.74724ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:36.416758Z","caller":"traceutil/trace.go:171","msg":"trace[319107671] linearizableReadLoop","detail":"{readStateIndex:24529; appliedIndex:24527; }","duration":"277.623619ms","start":"2026-02-25T20:40:36.139105Z","end":"2026-02-25T20:40:36.416729Z","steps":["trace[319107671] 'read index received'  (duration: 120.354162ms)","trace[319107671] 'applied index is now lower than readState.Index'  (duration: 157.267887ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:36.416804Z","caller":"traceutil/trace.go:171","msg":"trace[1360351586] transaction","detail":"{read_only:false; response_revision:23700; number_of_response:1; }","duration":"277.608068ms","start":"2026-02-25T20:40:36.139171Z","end":"2026-02-25T20:40:36.416779Z","steps":["trace[1360351586] 'process raft request'  (duration: 277.454164ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:36.416796Z","caller":"traceutil/trace.go:171","msg":"trace[266180631] transaction","detail":"{read_only:false; response_revision:23699; number_of_response:1; }","duration":"277.708561ms","start":"2026-02-25T20:40:36.139039Z","end":"2026-02-25T20:40:36.416747Z","steps":["trace[266180631] 'process raft request'  (duration: 277.412034ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:36.41702Z","caller":"traceutil/trace.go:171","msg":"trace[1937568485] transaction","detail":"{read_only:false; response_revision:23701; number_of_response:1; }","duration":"276.965851ms","start":"2026-02-25T20:40:36.140014Z","end":"2026-02-25T20:40:36.41698Z","steps":["trace[1937568485] 'process raft request'  (duration: 276.659362ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:36.418222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.10084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:134 size:1314294"}
{"level":"info","ts":"2026-02-25T20:40:36.418275Z","caller":"traceutil/trace.go:171","msg":"trace[1752724060] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:134; response_revision:23701; }","duration":"279.237663ms","start":"2026-02-25T20:40:36.139026Z","end":"2026-02-25T20:40:36.418264Z","steps":["trace[1752724060] 'agreement among raft nodes before linearized reading'  (duration: 277.819204ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:36.542138Z","caller":"traceutil/trace.go:171","msg":"trace[1935769807] transaction","detail":"{read_only:false; response_revision:23702; number_of_response:1; }","duration":"104.070924ms","start":"2026-02-25T20:40:36.438023Z","end":"2026-02-25T20:40:36.542094Z","steps":["trace[1935769807] 'process raft request'  (duration: 102.034768ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:37.748119Z","caller":"traceutil/trace.go:171","msg":"trace[1632623026] transaction","detail":"{read_only:false; response_revision:23705; number_of_response:1; }","duration":"109.483649ms","start":"2026-02-25T20:40:37.638592Z","end":"2026-02-25T20:40:37.748076Z","steps":["trace[1632623026] 'process raft request'  (duration: 109.182651ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:37.969565Z","caller":"traceutil/trace.go:171","msg":"trace[1394334365] transaction","detail":"{read_only:false; response_revision:23706; number_of_response:1; }","duration":"190.402199ms","start":"2026-02-25T20:40:37.779125Z","end":"2026-02-25T20:40:37.969527Z","steps":["trace[1394334365] 'process raft request'  (duration: 126.513167ms)","trace[1394334365] 'compare'  (duration: 63.689166ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:37.970471Z","caller":"traceutil/trace.go:171","msg":"trace[1042453752] linearizableReadLoop","detail":"{readStateIndex:24539; appliedIndex:24535; }","duration":"169.058283ms","start":"2026-02-25T20:40:37.801395Z","end":"2026-02-25T20:40:37.970453Z","steps":["trace[1042453752] 'read index received'  (duration: 104.243377ms)","trace[1042453752] 'applied index is now lower than readState.Index'  (duration: 64.813326ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:37.970518Z","caller":"traceutil/trace.go:171","msg":"trace[2017547574] transaction","detail":"{read_only:false; response_revision:23707; number_of_response:1; }","duration":"191.123738ms","start":"2026-02-25T20:40:37.779372Z","end":"2026-02-25T20:40:37.970496Z","steps":["trace[2017547574] 'process raft request'  (duration: 190.895502ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:37.970571Z","caller":"traceutil/trace.go:171","msg":"trace[1995315902] transaction","detail":"{read_only:false; response_revision:23709; number_of_response:1; }","duration":"188.403985ms","start":"2026-02-25T20:40:37.782142Z","end":"2026-02-25T20:40:37.970546Z","steps":["trace[1995315902] 'process raft request'  (duration: 188.282391ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:37.970556Z","caller":"traceutil/trace.go:171","msg":"trace[1292875318] transaction","detail":"{read_only:false; response_revision:23708; number_of_response:1; }","duration":"190.126912ms","start":"2026-02-25T20:40:37.78039Z","end":"2026-02-25T20:40:37.970517Z","steps":["trace[1292875318] 'process raft request'  (duration: 189.998678ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:37.970637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.236728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"info","ts":"2026-02-25T20:40:37.970664Z","caller":"traceutil/trace.go:171","msg":"trace[433476797] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23709; }","duration":"169.337851ms","start":"2026-02-25T20:40:37.801318Z","end":"2026-02-25T20:40:37.970656Z","steps":["trace[433476797] 'agreement among raft nodes before linearized reading'  (duration: 169.200887ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:38.273829Z","caller":"traceutil/trace.go:171","msg":"trace[1475944587] linearizableReadLoop","detail":"{readStateIndex:24540; appliedIndex:24539; }","duration":"101.515015ms","start":"2026-02-25T20:40:38.172286Z","end":"2026-02-25T20:40:38.273801Z","steps":["trace[1475944587] 'read index received'  (duration: 101.268508ms)","trace[1475944587] 'applied index is now lower than readState.Index'  (duration: 245.287µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:38.27397Z","caller":"traceutil/trace.go:171","msg":"trace[1160674345] transaction","detail":"{read_only:false; response_revision:23710; number_of_response:1; }","duration":"131.671788ms","start":"2026-02-25T20:40:38.14226Z","end":"2026-02-25T20:40:38.273932Z","steps":["trace[1160674345] 'process raft request'  (duration: 131.340249ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.274087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.781002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-02-25T20:40:38.274136Z","caller":"traceutil/trace.go:171","msg":"trace[1083831253] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:23710; }","duration":"101.856244ms","start":"2026-02-25T20:40:38.172269Z","end":"2026-02-25T20:40:38.274125Z","steps":["trace[1083831253] 'agreement among raft nodes before linearized reading'  (duration: 101.645148ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:38.693028Z","caller":"traceutil/trace.go:171","msg":"trace[522739563] transaction","detail":"{read_only:false; response_revision:23712; number_of_response:1; }","duration":"286.086937ms","start":"2026-02-25T20:40:38.40691Z","end":"2026-02-25T20:40:38.692996Z","steps":["trace[522739563] 'process raft request'  (duration: 285.897152ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:38.693156Z","caller":"traceutil/trace.go:171","msg":"trace[110068714] linearizableReadLoop","detail":"{readStateIndex:24543; appliedIndex:24543; }","duration":"272.730297ms","start":"2026-02-25T20:40:38.420376Z","end":"2026-02-25T20:40:38.693107Z","steps":["trace[110068714] 'read index received'  (duration: 272.707066ms)","trace[110068714] 'applied index is now lower than readState.Index'  (duration: 19.411µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:38.693596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.179329ms","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-02-25T20:40:38.693642Z","caller":"traceutil/trace.go:171","msg":"trace[1460084460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23712; }","duration":"273.275601ms","start":"2026-02-25T20:40:38.420356Z","end":"2026-02-25T20:40:38.693631Z","steps":["trace[1460084460] 'agreement among raft nodes before linearized reading'  (duration: 272.930372ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.842084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.550131ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555473624 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:23665 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:38.842427Z","caller":"traceutil/trace.go:171","msg":"trace[968916684] transaction","detail":"{read_only:false; response_revision:23715; number_of_response:1; }","duration":"139.661703ms","start":"2026-02-25T20:40:38.702744Z","end":"2026-02-25T20:40:38.842406Z","steps":["trace[968916684] 'process raft request'  (duration: 139.608851ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:38.842597Z","caller":"traceutil/trace.go:171","msg":"trace[1613999971] transaction","detail":"{read_only:false; response_revision:23714; number_of_response:1; }","duration":"254.820635ms","start":"2026-02-25T20:40:38.587743Z","end":"2026-02-25T20:40:38.842564Z","steps":["trace[1613999971] 'process raft request'  (duration: 254.472296ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:38.842699Z","caller":"traceutil/trace.go:171","msg":"trace[246750528] transaction","detail":"{read_only:false; response_revision:23713; number_of_response:1; }","duration":"352.440014ms","start":"2026-02-25T20:40:38.490201Z","end":"2026-02-25T20:40:38.842641Z","steps":["trace[246750528] 'process raft request'  (duration: 219.179305ms)","trace[246750528] 'compare'  (duration: 132.18086ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:38.842927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.490186Z","time spent":"352.615098ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:23665 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:38.843283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.82974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:38.843326Z","caller":"traceutil/trace.go:171","msg":"trace[1873437649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23715; }","duration":"305.903292ms","start":"2026-02-25T20:40:38.537411Z","end":"2026-02-25T20:40:38.843315Z","steps":["trace[1873437649] 'agreement among raft nodes before linearized reading'  (duration: 305.82018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.843328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.799292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-02-25T20:40:38.843364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.537396Z","time spent":"305.961693ms","remote":"127.0.0.1:33844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T20:40:38.843388Z","caller":"traceutil/trace.go:171","msg":"trace[1408713975] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:23715; }","duration":"281.882274ms","start":"2026-02-25T20:40:38.561491Z","end":"2026-02-25T20:40:38.843373Z","steps":["trace[1408713975] 'agreement among raft nodes before linearized reading'  (duration: 281.755981ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.843518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.755692ms","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-02-25T20:40:38.843185Z","caller":"traceutil/trace.go:171","msg":"trace[631446781] linearizableReadLoop","detail":"{readStateIndex:24545; appliedIndex:24543; }","duration":"149.925569ms","start":"2026-02-25T20:40:38.693241Z","end":"2026-02-25T20:40:38.843167Z","steps":["trace[631446781] 'read index received'  (duration: 16.060442ms)","trace[631446781] 'applied index is now lower than readState.Index'  (duration: 133.862407ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:38.843599Z","caller":"traceutil/trace.go:171","msg":"trace[95979442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23715; }","duration":"421.837435ms","start":"2026-02-25T20:40:38.421726Z","end":"2026-02-25T20:40:38.843564Z","steps":["trace[95979442] 'agreement among raft nodes before linearized reading'  (duration: 421.635539ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.843536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.621246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" ","response":"range_response_count:1 size:22018"}
{"level":"warn","ts":"2026-02-25T20:40:38.843651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.421721Z","time spent":"421.921537ms","remote":"127.0.0.1:34100","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-02-25T20:40:38.843565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.611499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-02-25T20:40:38.843674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.906163ms","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-02-25T20:40:38.843707Z","caller":"traceutil/trace.go:171","msg":"trace[1693798310] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-lsg6c; range_end:; response_count:1; response_revision:23715; }","duration":"402.777651ms","start":"2026-02-25T20:40:38.440873Z","end":"2026-02-25T20:40:38.843651Z","steps":["trace[1693798310] 'agreement among raft nodes before linearized reading'  (duration: 402.442862ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.843754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.440865Z","time spent":"402.877453ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22042,"request content":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" "}
{"level":"info","ts":"2026-02-25T20:40:38.843753Z","caller":"traceutil/trace.go:171","msg":"trace[1168655700] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23715; }","duration":"423.011746ms","start":"2026-02-25T20:40:38.420716Z","end":"2026-02-25T20:40:38.843728Z","steps":["trace[1168655700] 'agreement among raft nodes before linearized reading'  (duration: 422.79287ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:38.843751Z","caller":"traceutil/trace.go:171","msg":"trace[286847221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23715; }","duration":"297.822664ms","start":"2026-02-25T20:40:38.545878Z","end":"2026-02-25T20:40:38.843701Z","steps":["trace[286847221] 'agreement among raft nodes before linearized reading'  (duration: 297.401493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:38.84384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.420706Z","time spent":"423.112518ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T20:40:39.190428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.002119ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555473631 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23701 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:39.190838Z","caller":"traceutil/trace.go:171","msg":"trace[1948993374] transaction","detail":"{read_only:false; response_revision:23717; number_of_response:1; }","duration":"341.726655ms","start":"2026-02-25T20:40:38.849029Z","end":"2026-02-25T20:40:39.190756Z","steps":["trace[1948993374] 'process raft request'  (duration: 206.950785ms)","trace[1948993374] 'compare'  (duration: 133.877726ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:39.191125Z","caller":"traceutil/trace.go:171","msg":"trace[1064936786] transaction","detail":"{read_only:false; response_revision:23718; number_of_response:1; }","duration":"342.043884ms","start":"2026-02-25T20:40:38.849039Z","end":"2026-02-25T20:40:39.191083Z","steps":["trace[1064936786] 'process raft request'  (duration: 341.612963ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:39.191211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.849019Z","time spent":"342.146996ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:23699 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T20:40:39.191398Z","caller":"traceutil/trace.go:171","msg":"trace[68538681] linearizableReadLoop","detail":"{readStateIndex:24550; appliedIndex:24546; }","duration":"341.951881ms","start":"2026-02-25T20:40:38.849437Z","end":"2026-02-25T20:40:39.191389Z","steps":["trace[68538681] 'read index received'  (duration: 4.516381ms)","trace[68538681] 'applied index is now lower than readState.Index'  (duration: 337.43433ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:39.191353Z","caller":"traceutil/trace.go:171","msg":"trace[1282807040] transaction","detail":"{read_only:false; response_revision:23719; number_of_response:1; }","duration":"341.89172ms","start":"2026-02-25T20:40:38.849412Z","end":"2026-02-25T20:40:39.191304Z","steps":["trace[1282807040] 'process raft request'  (duration: 341.576002ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:39.191406Z","caller":"traceutil/trace.go:171","msg":"trace[599113398] transaction","detail":"{read_only:false; response_revision:23720; number_of_response:1; }","duration":"277.541366ms","start":"2026-02-25T20:40:38.913834Z","end":"2026-02-25T20:40:39.191375Z","steps":["trace[599113398] 'process raft request'  (duration: 277.416103ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:39.191599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.571906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-02-25T20:40:39.191632Z","caller":"traceutil/trace.go:171","msg":"trace[1816437278] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:23720; }","duration":"222.683949ms","start":"2026-02-25T20:40:38.968937Z","end":"2026-02-25T20:40:39.191621Z","steps":["trace[1816437278] 'agreement among raft nodes before linearized reading'  (duration: 222.534425ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:39.191623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.849389Z","time spent":"342.066065ms","remote":"127.0.0.1:34100","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:23702 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:39.19185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.849019Z","time spent":"341.885989ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23701 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:39.192891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.42133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:134 size:1314294"}
{"level":"info","ts":"2026-02-25T20:40:39.192995Z","caller":"traceutil/trace.go:171","msg":"trace[1107457138] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:134; response_revision:23720; }","duration":"343.563954ms","start":"2026-02-25T20:40:38.849408Z","end":"2026-02-25T20:40:39.192972Z","steps":["trace[1107457138] 'agreement among raft nodes before linearized reading'  (duration: 342.054114ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:39.193452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:38.849353Z","time spent":"343.682118ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":134,"response size":1314318,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-02-25T20:40:39.655917Z","caller":"traceutil/trace.go:171","msg":"trace[993622439] linearizableReadLoop","detail":"{readStateIndex:24552; appliedIndex:24551; }","duration":"117.68779ms","start":"2026-02-25T20:40:39.538201Z","end":"2026-02-25T20:40:39.655889Z","steps":["trace[993622439] 'read index received'  (duration: 117.536396ms)","trace[993622439] 'applied index is now lower than readState.Index'  (duration: 149.744µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:39.656059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.834525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:39.656049Z","caller":"traceutil/trace.go:171","msg":"trace[465855335] transaction","detail":"{read_only:false; response_revision:23721; number_of_response:1; }","duration":"122.688686ms","start":"2026-02-25T20:40:39.533299Z","end":"2026-02-25T20:40:39.655987Z","steps":["trace[465855335] 'process raft request'  (duration: 122.389698ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:39.656113Z","caller":"traceutil/trace.go:171","msg":"trace[837260068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23721; }","duration":"117.961688ms","start":"2026-02-25T20:40:39.538139Z","end":"2026-02-25T20:40:39.656101Z","steps":["trace[837260068] 'agreement among raft nodes before linearized reading'  (duration: 117.857295ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.145746Z","caller":"traceutil/trace.go:171","msg":"trace[805699857] transaction","detail":"{read_only:false; response_revision:23723; number_of_response:1; }","duration":"169.794525ms","start":"2026-02-25T20:40:39.97592Z","end":"2026-02-25T20:40:40.145714Z","steps":["trace[805699857] 'process raft request'  (duration: 169.582528ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.267943Z","caller":"traceutil/trace.go:171","msg":"trace[1395601143] transaction","detail":"{read_only:false; response_revision:23724; number_of_response:1; }","duration":"291.889423ms","start":"2026-02-25T20:40:39.976016Z","end":"2026-02-25T20:40:40.267906Z","steps":["trace[1395601143] 'process raft request'  (duration: 289.089447ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.268017Z","caller":"traceutil/trace.go:171","msg":"trace[663619775] linearizableReadLoop","detail":"{readStateIndex:24557; appliedIndex:24553; }","duration":"239.087721ms","start":"2026-02-25T20:40:40.028889Z","end":"2026-02-25T20:40:40.267977Z","steps":["trace[663619775] 'read index received'  (duration: 116.716644ms)","trace[663619775] 'applied index is now lower than readState.Index'  (duration: 122.369307ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:40.268261Z","caller":"traceutil/trace.go:171","msg":"trace[393641171] transaction","detail":"{read_only:false; response_revision:23725; number_of_response:1; }","duration":"291.946435ms","start":"2026-02-25T20:40:39.976296Z","end":"2026-02-25T20:40:40.268243Z","steps":["trace[393641171] 'process raft request'  (duration: 291.465512ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:40.268376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.459781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"info","ts":"2026-02-25T20:40:40.26835Z","caller":"traceutil/trace.go:171","msg":"trace[342382030] transaction","detail":"{read_only:false; response_revision:23726; number_of_response:1; }","duration":"291.229726ms","start":"2026-02-25T20:40:39.977053Z","end":"2026-02-25T20:40:40.268282Z","steps":["trace[342382030] 'process raft request'  (duration: 290.859186ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.268426Z","caller":"traceutil/trace.go:171","msg":"trace[730804621] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23726; }","duration":"239.581894ms","start":"2026-02-25T20:40:40.028829Z","end":"2026-02-25T20:40:40.268411Z","steps":["trace[730804621] 'agreement among raft nodes before linearized reading'  (duration: 239.297547ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.463361Z","caller":"traceutil/trace.go:171","msg":"trace[1749158772] linearizableReadLoop","detail":"{readStateIndex:24558; appliedIndex:24557; }","duration":"119.571101ms","start":"2026-02-25T20:40:40.343762Z","end":"2026-02-25T20:40:40.463333Z","steps":["trace[1749158772] 'read index received'  (duration: 29.526656ms)","trace[1749158772] 'applied index is now lower than readState.Index'  (duration: 90.043285ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:40.463779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.971252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-02-25T20:40:40.463873Z","caller":"traceutil/trace.go:171","msg":"trace[955565830] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:23727; }","duration":"120.182357ms","start":"2026-02-25T20:40:40.343668Z","end":"2026-02-25T20:40:40.46385Z","steps":["trace[955565830] 'agreement among raft nodes before linearized reading'  (duration: 119.768986ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.463455Z","caller":"traceutil/trace.go:171","msg":"trace[1228326819] transaction","detail":"{read_only:false; response_revision:23727; number_of_response:1; }","duration":"184.257034ms","start":"2026-02-25T20:40:40.279163Z","end":"2026-02-25T20:40:40.46342Z","steps":["trace[1228326819] 'process raft request'  (duration: 94.191197ms)","trace[1228326819] 'compare'  (duration: 89.81346ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:40.694787Z","caller":"traceutil/trace.go:171","msg":"trace[1999410162] linearizableReadLoop","detail":"{readStateIndex:24559; appliedIndex:24558; }","duration":"155.663034ms","start":"2026-02-25T20:40:40.539092Z","end":"2026-02-25T20:40:40.694755Z","steps":["trace[1999410162] 'read index received'  (duration: 155.442827ms)","trace[1999410162] 'applied index is now lower than readState.Index'  (duration: 218.927µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:40.694905Z","caller":"traceutil/trace.go:171","msg":"trace[253696558] transaction","detail":"{read_only:false; response_revision:23728; number_of_response:1; }","duration":"226.211944ms","start":"2026-02-25T20:40:40.468659Z","end":"2026-02-25T20:40:40.694871Z","steps":["trace[253696558] 'process raft request'  (duration: 225.889375ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:40.694947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.834728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:40.694993Z","caller":"traceutil/trace.go:171","msg":"trace[1461446442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23728; }","duration":"155.961552ms","start":"2026-02-25T20:40:40.539018Z","end":"2026-02-25T20:40:40.69498Z","steps":["trace[1461446442] 'agreement among raft nodes before linearized reading'  (duration: 155.855459ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:40.797862Z","caller":"traceutil/trace.go:171","msg":"trace[2075316630] linearizableReadLoop","detail":"{readStateIndex:24560; appliedIndex:24559; }","duration":"101.380451ms","start":"2026-02-25T20:40:40.696433Z","end":"2026-02-25T20:40:40.797814Z","steps":["trace[2075316630] 'read index received'  (duration: 100.268541ms)","trace[2075316630] 'applied index is now lower than readState.Index'  (duration: 1.11017ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:40.798251Z","caller":"traceutil/trace.go:171","msg":"trace[1295029061] transaction","detail":"{read_only:false; response_revision:23729; number_of_response:1; }","duration":"238.853104ms","start":"2026-02-25T20:40:40.559156Z","end":"2026-02-25T20:40:40.79801Z","steps":["trace[1295029061] 'process raft request'  (duration: 237.611701ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:40.798402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.897605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:40.798551Z","caller":"traceutil/trace.go:171","msg":"trace[1697366731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23729; }","duration":"102.160383ms","start":"2026-02-25T20:40:40.696356Z","end":"2026-02-25T20:40:40.798517Z","steps":["trace[1697366731] 'agreement among raft nodes before linearized reading'  (duration: 101.584116ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:42.534049Z","caller":"traceutil/trace.go:171","msg":"trace[1667858162] transaction","detail":"{read_only:false; response_revision:23738; number_of_response:1; }","duration":"258.935756ms","start":"2026-02-25T20:40:42.275076Z","end":"2026-02-25T20:40:42.534012Z","steps":["trace[1667858162] 'process raft request'  (duration: 258.70184ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:42.862471Z","caller":"traceutil/trace.go:171","msg":"trace[1832394994] transaction","detail":"{read_only:false; response_revision:23739; number_of_response:1; }","duration":"586.826268ms","start":"2026-02-25T20:40:42.275605Z","end":"2026-02-25T20:40:42.862431Z","steps":["trace[1832394994] 'process raft request'  (duration: 585.196234ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:42.862534Z","caller":"traceutil/trace.go:171","msg":"trace[385597666] linearizableReadLoop","detail":"{readStateIndex:24571; appliedIndex:24568; }","duration":"563.987953ms","start":"2026-02-25T20:40:42.298506Z","end":"2026-02-25T20:40:42.862493Z","steps":["trace[385597666] 'read index received'  (duration: 235.277489ms)","trace[385597666] 'applied index is now lower than readState.Index'  (duration: 328.708364ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:42.862646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:42.275525Z","time spent":"587.027414ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23724 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-02-25T20:40:42.862766Z","caller":"traceutil/trace.go:171","msg":"trace[823233041] transaction","detail":"{read_only:false; response_revision:23741; number_of_response:1; }","duration":"392.963515ms","start":"2026-02-25T20:40:42.469762Z","end":"2026-02-25T20:40:42.862726Z","steps":["trace[823233041] 'process raft request'  (duration: 392.629997ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:42.862988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:42.469726Z","time spent":"393.13351ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:23727 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:42.863234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.210598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:42.863275Z","caller":"traceutil/trace.go:171","msg":"trace[116316095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23741; }","duration":"323.29508ms","start":"2026-02-25T20:40:42.539968Z","end":"2026-02-25T20:40:42.863263Z","steps":["trace[116316095] 'agreement among raft nodes before linearized reading'  (duration: 323.215238ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:42.863277Z","caller":"traceutil/trace.go:171","msg":"trace[1718349930] transaction","detail":"{read_only:false; response_revision:23740; number_of_response:1; }","duration":"583.921121ms","start":"2026-02-25T20:40:42.279338Z","end":"2026-02-25T20:40:42.86326Z","steps":["trace[1718349930] 'process raft request'  (duration: 582.959144ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:42.863304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:42.53994Z","time spent":"323.358002ms","remote":"127.0.0.1:33852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T20:40:42.863361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:42.279328Z","time spent":"583.978203ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:23725 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:42.86349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.264373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:42.86353Z","caller":"traceutil/trace.go:171","msg":"trace[1116117785] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:23741; }","duration":"279.330365ms","start":"2026-02-25T20:40:42.584191Z","end":"2026-02-25T20:40:42.863521Z","steps":["trace[1116117785] 'agreement among raft nodes before linearized reading'  (duration: 279.261113ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:42.864293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.429225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"info","ts":"2026-02-25T20:40:42.864389Z","caller":"traceutil/trace.go:171","msg":"trace[1708867733] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23741; }","duration":"565.893505ms","start":"2026-02-25T20:40:42.298473Z","end":"2026-02-25T20:40:42.864366Z","steps":["trace[1708867733] 'agreement among raft nodes before linearized reading'  (duration: 564.259621ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:42.864457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:42.298465Z","time spent":"565.966137ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9733,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" "}
{"level":"info","ts":"2026-02-25T20:40:44.959537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20514}
{"level":"info","ts":"2026-02-25T20:40:45.08968Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20514,"took":"124.925775ms","hash":386553399,"current-db-size-bytes":47296512,"current-db-size":"47 MB","current-db-size-in-use-bytes":39079936,"current-db-size-in-use":"39 MB"}
{"level":"info","ts":"2026-02-25T20:40:45.089755Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":386553399,"revision":20514,"compact-revision":18387}
{"level":"warn","ts":"2026-02-25T20:40:50.156697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.376999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-02-25T20:40:50.156803Z","caller":"traceutil/trace.go:171","msg":"trace[1009135142] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:23850; }","duration":"141.549263ms","start":"2026-02-25T20:40:50.015229Z","end":"2026-02-25T20:40:50.156779Z","steps":["trace[1009135142] 'range keys from in-memory index tree'  (duration: 141.08972ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:50.314864Z","caller":"traceutil/trace.go:171","msg":"trace[1395331379] transaction","detail":"{read_only:false; response_revision:23851; number_of_response:1; }","duration":"121.578935ms","start":"2026-02-25T20:40:50.193261Z","end":"2026-02-25T20:40:50.31484Z","steps":["trace[1395331379] 'process raft request'  (duration: 121.42157ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:50.329179Z","caller":"traceutil/trace.go:171","msg":"trace[50872565] linearizableReadLoop","detail":"{readStateIndex:24686; appliedIndex:24685; }","duration":"106.505778ms","start":"2026-02-25T20:40:50.222646Z","end":"2026-02-25T20:40:50.329152Z","steps":["trace[50872565] 'read index received'  (duration: 92.220924ms)","trace[50872565] 'applied index is now lower than readState.Index'  (duration: 14.283594ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:50.329226Z","caller":"traceutil/trace.go:171","msg":"trace[1440966139] transaction","detail":"{read_only:false; response_revision:23852; number_of_response:1; }","duration":"135.503651ms","start":"2026-02-25T20:40:50.193701Z","end":"2026-02-25T20:40:50.329204Z","steps":["trace[1440966139] 'process raft request'  (duration: 135.271115ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:50.329317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.660093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:40:50.329353Z","caller":"traceutil/trace.go:171","msg":"trace[582717526] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:23852; }","duration":"106.783897ms","start":"2026-02-25T20:40:50.222558Z","end":"2026-02-25T20:40:50.329342Z","steps":["trace[582717526] 'agreement among raft nodes before linearized reading'  (duration: 106.698124ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:50.711757Z","caller":"traceutil/trace.go:171","msg":"trace[483556985] transaction","detail":"{read_only:false; response_revision:23853; number_of_response:1; }","duration":"138.879321ms","start":"2026-02-25T20:40:50.572838Z","end":"2026-02-25T20:40:50.711717Z","steps":["trace[483556985] 'process raft request'  (duration: 138.641375ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:50.99081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.784139ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474014 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:23763 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:517 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:50.99102Z","caller":"traceutil/trace.go:171","msg":"trace[418383567] transaction","detail":"{read_only:false; response_revision:23854; number_of_response:1; }","duration":"159.692791ms","start":"2026-02-25T20:40:50.83125Z","end":"2026-02-25T20:40:50.990943Z","steps":["trace[418383567] 'process raft request'  (duration: 30.643435ms)","trace[418383567] 'compare'  (duration: 128.223174ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:51.215957Z","caller":"traceutil/trace.go:171","msg":"trace[1111498041] transaction","detail":"{read_only:false; response_revision:23855; number_of_response:1; }","duration":"325.518829ms","start":"2026-02-25T20:40:50.890384Z","end":"2026-02-25T20:40:51.215903Z","steps":["trace[1111498041] 'process raft request'  (duration: 245.70167ms)","trace[1111498041] 'compare'  (duration: 79.385708ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:51.216036Z","caller":"traceutil/trace.go:171","msg":"trace[58254458] transaction","detail":"{read_only:false; response_revision:23856; number_of_response:1; }","duration":"323.231058ms","start":"2026-02-25T20:40:50.892787Z","end":"2026-02-25T20:40:51.216018Z","steps":["trace[58254458] 'process raft request'  (duration: 323.028892ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:51.216036Z","caller":"traceutil/trace.go:171","msg":"trace[1099777211] linearizableReadLoop","detail":"{readStateIndex:24691; appliedIndex:24688; }","duration":"312.287562ms","start":"2026-02-25T20:40:50.903719Z","end":"2026-02-25T20:40:51.216007Z","steps":["trace[1099777211] 'read index received'  (duration: 232.305788ms)","trace[1099777211] 'applied index is now lower than readState.Index'  (duration: 79.980454ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:51.21617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:50.892759Z","time spent":"323.333911ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:23830 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-02-25T20:40:51.216215Z","caller":"traceutil/trace.go:171","msg":"trace[1591329454] transaction","detail":"{read_only:false; response_revision:23857; number_of_response:1; }","duration":"323.193056ms","start":"2026-02-25T20:40:50.893001Z","end":"2026-02-25T20:40:51.216194Z","steps":["trace[1591329454] 'process raft request'  (duration: 322.94686ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:51.216307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:50.892944Z","time spent":"323.30978ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23829 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:51.216208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:50.890348Z","time spent":"325.727225ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:23828 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:51.216451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.338743ms","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-02-25T20:40:51.216478Z","caller":"traceutil/trace.go:171","msg":"trace[1845783133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23857; }","duration":"306.421605ms","start":"2026-02-25T20:40:50.91005Z","end":"2026-02-25T20:40:51.216472Z","steps":["trace[1845783133] 'agreement among raft nodes before linearized reading'  (duration: 306.299201ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:51.216507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:50.91002Z","time spent":"306.482476ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T20:40:51.216603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.72618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b368271c-5cc3-495c-bda5-f292ae2bec91\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-02-25T20:40:51.216629Z","caller":"traceutil/trace.go:171","msg":"trace[383978642] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b368271c-5cc3-495c-bda5-f292ae2bec91; range_end:; response_count:1; response_revision:23857; }","duration":"297.770392ms","start":"2026-02-25T20:40:50.918849Z","end":"2026-02-25T20:40:51.21662Z","steps":["trace[383978642] 'agreement among raft nodes before linearized reading'  (duration: 297.70475ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:51.216611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.18328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"warn","ts":"2026-02-25T20:40:51.216611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.704939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"warn","ts":"2026-02-25T20:40:51.216629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.886859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T20:40:51.216684Z","caller":"traceutil/trace.go:171","msg":"trace[157609447] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:23857; }","duration":"266.282034ms","start":"2026-02-25T20:40:50.950384Z","end":"2026-02-25T20:40:51.216666Z","steps":["trace[157609447] 'agreement among raft nodes before linearized reading'  (duration: 266.063368ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:51.216725Z","caller":"traceutil/trace.go:171","msg":"trace[1270353123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23857; }","duration":"313.022792ms","start":"2026-02-25T20:40:50.90368Z","end":"2026-02-25T20:40:51.216703Z","steps":["trace[1270353123] 'agreement among raft nodes before linearized reading'  (duration: 312.711823ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:51.216718Z","caller":"traceutil/trace.go:171","msg":"trace[1697032761] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23857; }","duration":"222.822312ms","start":"2026-02-25T20:40:50.993868Z","end":"2026-02-25T20:40:51.21669Z","steps":["trace[1697032761] 'agreement among raft nodes before linearized reading'  (duration: 222.521224ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:51.216814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:50.90367Z","time spent":"313.128426ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T20:40:57.496188Z","caller":"traceutil/trace.go:171","msg":"trace[72401787] transaction","detail":"{read_only:false; response_revision:23919; number_of_response:1; }","duration":"260.811687ms","start":"2026-02-25T20:40:57.23535Z","end":"2026-02-25T20:40:57.496162Z","steps":["trace[72401787] 'process raft request'  (duration: 260.655902ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:57.800172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.078669ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474167 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:23895 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:57.800348Z","caller":"traceutil/trace.go:171","msg":"trace[533118882] linearizableReadLoop","detail":"{readStateIndex:24757; appliedIndex:24754; }","duration":"480.636328ms","start":"2026-02-25T20:40:57.319693Z","end":"2026-02-25T20:40:57.800329Z","steps":["trace[533118882] 'read index received'  (duration: 176.392662ms)","trace[533118882] 'applied index is now lower than readState.Index'  (duration: 304.242196ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:40:57.800419Z","caller":"traceutil/trace.go:171","msg":"trace[250773894] transaction","detail":"{read_only:false; response_revision:23921; number_of_response:1; }","duration":"561.681342ms","start":"2026-02-25T20:40:57.238728Z","end":"2026-02-25T20:40:57.800409Z","steps":["trace[250773894] 'process raft request'  (duration: 561.535658ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:57.800477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.238687Z","time spent":"561.754214ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:23896 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-02-25T20:40:57.800532Z","caller":"traceutil/trace.go:171","msg":"trace[786809473] transaction","detail":"{read_only:false; response_revision:23920; number_of_response:1; }","duration":"564.145088ms","start":"2026-02-25T20:40:57.236356Z","end":"2026-02-25T20:40:57.800501Z","steps":["trace[786809473] 'process raft request'  (duration: 431.637418ms)","trace[786809473] 'compare'  (duration: 131.840222ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:57.800675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.236343Z","time spent":"564.253561ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:23895 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-02-25T20:40:57.800786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.093611ms","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-02-25T20:40:57.800837Z","caller":"traceutil/trace.go:171","msg":"trace[1554433947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23921; }","duration":"481.195244ms","start":"2026-02-25T20:40:57.319614Z","end":"2026-02-25T20:40:57.800809Z","steps":["trace[1554433947] 'agreement among raft nodes before linearized reading'  (duration: 481.06323ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:57.800872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.319564Z","time spent":"481.300956ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T20:40:58.087959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.046919ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474169 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23907 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:40:58.088149Z","caller":"traceutil/trace.go:171","msg":"trace[1992598870] transaction","detail":"{read_only:false; response_revision:23923; number_of_response:1; }","duration":"282.747177ms","start":"2026-02-25T20:40:57.805385Z","end":"2026-02-25T20:40:58.088133Z","steps":["trace[1992598870] 'process raft request'  (duration: 282.686006ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:40:58.088125Z","caller":"traceutil/trace.go:171","msg":"trace[667720354] transaction","detail":"{read_only:false; response_revision:23922; number_of_response:1; }","duration":"364.184121ms","start":"2026-02-25T20:40:57.723899Z","end":"2026-02-25T20:40:58.088083Z","steps":["trace[667720354] 'process raft request'  (duration: 186.924436ms)","trace[667720354] 'compare'  (duration: 176.913136ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:58.088289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.723871Z","time spent":"364.326625ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23907 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-02-25T20:40:58.088294Z","caller":"traceutil/trace.go:171","msg":"trace[960716867] linearizableReadLoop","detail":"{readStateIndex:24758; appliedIndex:24757; }","duration":"287.890715ms","start":"2026-02-25T20:40:57.800377Z","end":"2026-02-25T20:40:58.088268Z","steps":["trace[960716867] 'read index received'  (duration: 110.464876ms)","trace[960716867] 'applied index is now lower than readState.Index'  (duration: 177.423509ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:40:58.088492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.29133ms","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-02-25T20:40:58.088523Z","caller":"traceutil/trace.go:171","msg":"trace[1182020969] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23923; }","duration":"747.377903ms","start":"2026-02-25T20:40:57.341135Z","end":"2026-02-25T20:40:58.088513Z","steps":["trace[1182020969] 'agreement among raft nodes before linearized reading'  (duration: 747.231269ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.088544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.341114Z","time spent":"747.424775ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T20:40:58.088564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.735199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-02-25T20:40:58.088662Z","caller":"traceutil/trace.go:171","msg":"trace[241908147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23923; }","duration":"742.877403ms","start":"2026-02-25T20:40:57.345766Z","end":"2026-02-25T20:40:58.088643Z","steps":["trace[241908147] 'agreement among raft nodes before linearized reading'  (duration: 742.569794ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.088674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.523841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"info","ts":"2026-02-25T20:40:58.088694Z","caller":"traceutil/trace.go:171","msg":"trace[1573632553] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:23923; }","duration":"707.589372ms","start":"2026-02-25T20:40:57.381099Z","end":"2026-02-25T20:40:58.088688Z","steps":["trace[1573632553] 'agreement among raft nodes before linearized reading'  (duration: 707.52181ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.088702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.345755Z","time spent":"742.939135ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T20:40:58.088709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.381072Z","time spent":"707.632814ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9733,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" "}
{"level":"warn","ts":"2026-02-25T20:40:58.088717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.570918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T20:40:58.088757Z","caller":"traceutil/trace.go:171","msg":"trace[1862060725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23923; }","duration":"767.63144ms","start":"2026-02-25T20:40:57.321115Z","end":"2026-02-25T20:40:58.088746Z","steps":["trace[1862060725] 'agreement among raft nodes before linearized reading'  (duration: 767.454035ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.088562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.625036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-02-25T20:40:58.088793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.321107Z","time spent":"767.679341ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T20:40:58.088756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.656243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" ","response":"range_response_count:1 size:22018"}
{"level":"info","ts":"2026-02-25T20:40:58.08883Z","caller":"traceutil/trace.go:171","msg":"trace[1060503458] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23923; }","duration":"742.928735ms","start":"2026-02-25T20:40:57.345866Z","end":"2026-02-25T20:40:58.088795Z","steps":["trace[1060503458] 'agreement among raft nodes before linearized reading'  (duration: 742.40702ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.088892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.345853Z","time spent":"743.021487ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-25T20:40:58.08891Z","caller":"traceutil/trace.go:171","msg":"trace[365375973] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-lsg6c; range_end:; response_count:1; response_revision:23923; }","duration":"632.8915ms","start":"2026-02-25T20:40:57.455978Z","end":"2026-02-25T20:40:58.08887Z","steps":["trace[365375973] 'agreement among raft nodes before linearized reading'  (duration: 632.320364ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.088978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:40:57.455957Z","time spent":"633.004902ms","remote":"127.0.0.1:34020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22042,"request content":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" "}
{"level":"info","ts":"2026-02-25T20:40:58.094173Z","caller":"traceutil/trace.go:171","msg":"trace[868723776] transaction","detail":"{read_only:false; response_revision:23924; number_of_response:1; }","duration":"144.77269ms","start":"2026-02-25T20:40:57.949377Z","end":"2026-02-25T20:40:58.09415Z","steps":["trace[868723776] 'process raft request'  (duration: 143.789653ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:40:58.094318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.356171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-02-25T20:40:58.094405Z","caller":"traceutil/trace.go:171","msg":"trace[1628168728] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:23924; }","duration":"163.465174ms","start":"2026-02-25T20:40:57.930913Z","end":"2026-02-25T20:40:58.094378Z","steps":["trace[1628168728] 'agreement among raft nodes before linearized reading'  (duration: 163.231588ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:23.521508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.563138ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474718 > lease_revoke:<id:664b9c965a951fd9>","response":"size:30"}
{"level":"warn","ts":"2026-02-25T20:41:24.243745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.443947ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:41:24.243871Z","caller":"traceutil/trace.go:171","msg":"trace[1396739038] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24126; }","duration":"214.583111ms","start":"2026-02-25T20:41:24.029269Z","end":"2026-02-25T20:41:24.243852Z","steps":["trace[1396739038] 'range keys from in-memory index tree'  (duration: 214.430327ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:24.24409Z","caller":"traceutil/trace.go:171","msg":"trace[109575641] linearizableReadLoop","detail":"{readStateIndex:24971; appliedIndex:24969; }","duration":"237.986792ms","start":"2026-02-25T20:41:24.00608Z","end":"2026-02-25T20:41:24.244067Z","steps":["trace[109575641] 'read index received'  (duration: 207.460339ms)","trace[109575641] 'applied index is now lower than readState.Index'  (duration: 30.525463ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:24.2442Z","caller":"traceutil/trace.go:171","msg":"trace[453710398] transaction","detail":"{read_only:false; response_revision:24128; number_of_response:1; }","duration":"313.66688ms","start":"2026-02-25T20:41:23.930519Z","end":"2026-02-25T20:41:24.244186Z","steps":["trace[453710398] 'process raft request'  (duration: 313.477665ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:24.24417Z","caller":"traceutil/trace.go:171","msg":"trace[661985465] transaction","detail":"{read_only:false; response_revision:24127; number_of_response:1; }","duration":"314.615776ms","start":"2026-02-25T20:41:23.929497Z","end":"2026-02-25T20:41:24.244112Z","steps":["trace[661985465] 'process raft request'  (duration: 284.029102ms)","trace[661985465] 'compare'  (duration: 29.909706ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:24.244332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:23.930506Z","time spent":"313.738832ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24113 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-02-25T20:41:24.244332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.247318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:176"}
{"level":"warn","ts":"2026-02-25T20:41:24.244359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:23.929458Z","time spent":"314.805151ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24114 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-02-25T20:41:24.244402Z","caller":"traceutil/trace.go:171","msg":"trace[1193585074] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:24128; }","duration":"238.372981ms","start":"2026-02-25T20:41:24.006012Z","end":"2026-02-25T20:41:24.244385Z","steps":["trace[1193585074] 'agreement among raft nodes before linearized reading'  (duration: 238.205877ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:24.247565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.376646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-02-25T20:41:24.247653Z","caller":"traceutil/trace.go:171","msg":"trace[1498252714] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:24130; }","duration":"220.51555ms","start":"2026-02-25T20:41:24.027118Z","end":"2026-02-25T20:41:24.247634Z","steps":["trace[1498252714] 'agreement among raft nodes before linearized reading'  (duration: 220.345985ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:24.431361Z","caller":"traceutil/trace.go:171","msg":"trace[1869701408] transaction","detail":"{read_only:false; response_revision:24131; number_of_response:1; }","duration":"179.288489ms","start":"2026-02-25T20:41:24.252011Z","end":"2026-02-25T20:41:24.4313Z","steps":["trace[1869701408] 'process raft request'  (duration: 127.511114ms)","trace[1869701408] 'compare'  (duration: 51.540259ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:24.643965Z","caller":"traceutil/trace.go:171","msg":"trace[1827889149] transaction","detail":"{read_only:false; response_revision:24132; number_of_response:1; }","duration":"391.824146ms","start":"2026-02-25T20:41:24.252108Z","end":"2026-02-25T20:41:24.643932Z","steps":["trace[1827889149] 'process raft request'  (duration: 380.353367ms)","trace[1827889149] 'compare'  (duration: 10.842762ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:24.644176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:24.252089Z","time spent":"391.9855ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24119 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T20:41:24.644571Z","caller":"traceutil/trace.go:171","msg":"trace[895782092] linearizableReadLoop","detail":"{readStateIndex:24979; appliedIndex:24974; }","duration":"171.366597ms","start":"2026-02-25T20:41:24.473159Z","end":"2026-02-25T20:41:24.644526Z","steps":["trace[895782092] 'read index received'  (duration: 159.320122ms)","trace[895782092] 'applied index is now lower than readState.Index'  (duration: 12.044665ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:24.64464Z","caller":"traceutil/trace.go:171","msg":"trace[1724332206] transaction","detail":"{read_only:false; response_revision:24134; number_of_response:1; }","duration":"392.301518ms","start":"2026-02-25T20:41:24.252321Z","end":"2026-02-25T20:41:24.644622Z","steps":["trace[1724332206] 'process raft request'  (duration: 392.032551ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:24.644662Z","caller":"traceutil/trace.go:171","msg":"trace[1604011645] transaction","detail":"{read_only:false; response_revision:24136; number_of_response:1; }","duration":"173.496814ms","start":"2026-02-25T20:41:24.47113Z","end":"2026-02-25T20:41:24.644627Z","steps":["trace[1604011645] 'process raft request'  (duration: 173.3531ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:24.644711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:24.252311Z","time spent":"392.36669ms","remote":"127.0.0.1:34100","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:24120 > 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":"info","ts":"2026-02-25T20:41:24.644664Z","caller":"traceutil/trace.go:171","msg":"trace[1455150999] transaction","detail":"{read_only:false; response_revision:24135; number_of_response:1; }","duration":"392.244146ms","start":"2026-02-25T20:41:24.252379Z","end":"2026-02-25T20:41:24.644623Z","steps":["trace[1455150999] 'process raft request'  (duration: 392.057141ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:24.64467Z","caller":"traceutil/trace.go:171","msg":"trace[1306012258] transaction","detail":"{read_only:false; response_revision:24133; number_of_response:1; }","duration":"392.317798ms","start":"2026-02-25T20:41:24.252278Z","end":"2026-02-25T20:41:24.644595Z","steps":["trace[1306012258] 'process raft request'  (duration: 391.553028ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:24.644824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.659284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"warn","ts":"2026-02-25T20:41:24.64483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.42952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-02-25T20:41:24.644853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:24.252369Z","time spent":"392.389611ms","remote":"127.0.0.1:34100","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:24122 > 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-02-25T20:41:24.644871Z","caller":"traceutil/trace.go:171","msg":"trace[1172090976] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:24136; }","duration":"171.709245ms","start":"2026-02-25T20:41:24.473149Z","end":"2026-02-25T20:41:24.644858Z","steps":["trace[1172090976] 'agreement among raft nodes before linearized reading'  (duration: 171.51463ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:24.644878Z","caller":"traceutil/trace.go:171","msg":"trace[1246503147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24136; }","duration":"105.537473ms","start":"2026-02-25T20:41:24.539327Z","end":"2026-02-25T20:41:24.644864Z","steps":["trace[1246503147] 'agreement among raft nodes before linearized reading'  (duration: 105.43414ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:24.64488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.210498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-lsg6c\" ","response":"range_response_count:1 size:22018"}
{"level":"info","ts":"2026-02-25T20:41:24.644934Z","caller":"traceutil/trace.go:171","msg":"trace[1538518124] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-lsg6c; range_end:; response_count:1; response_revision:24136; }","duration":"143.29116ms","start":"2026-02-25T20:41:24.501629Z","end":"2026-02-25T20:41:24.644921Z","steps":["trace[1538518124] 'agreement among raft nodes before linearized reading'  (duration: 143.121356ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:24.644938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:24.252247Z","time spent":"392.542945ms","remote":"127.0.0.1:34100","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:24121 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-25T20:41:25.852242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.496472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-02-25T20:41:25.852374Z","caller":"traceutil/trace.go:171","msg":"trace[714861113] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24138; }","duration":"118.692027ms","start":"2026-02-25T20:41:25.733645Z","end":"2026-02-25T20:41:25.852337Z","steps":["trace[714861113] 'range keys from in-memory index tree'  (duration: 118.296106ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:25.966427Z","caller":"traceutil/trace.go:171","msg":"trace[233620699] transaction","detail":"{read_only:false; response_revision:24139; number_of_response:1; }","duration":"107.99014ms","start":"2026-02-25T20:41:25.858408Z","end":"2026-02-25T20:41:25.966399Z","steps":["trace[233620699] 'process raft request'  (duration: 107.683382ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:26.221724Z","caller":"traceutil/trace.go:171","msg":"trace[214757687] linearizableReadLoop","detail":"{readStateIndex:24983; appliedIndex:24982; }","duration":"177.873141ms","start":"2026-02-25T20:41:26.043815Z","end":"2026-02-25T20:41:26.221688Z","steps":["trace[214757687] 'read index received'  (duration: 157.339258ms)","trace[214757687] 'applied index is now lower than readState.Index'  (duration: 20.532333ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:26.221985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.148678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-02-25T20:41:26.222023Z","caller":"traceutil/trace.go:171","msg":"trace[1179128343] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24140; }","duration":"178.22392ms","start":"2026-02-25T20:41:26.043789Z","end":"2026-02-25T20:41:26.222013Z","steps":["trace[1179128343] 'agreement among raft nodes before linearized reading'  (duration: 178.005655ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:26.222007Z","caller":"traceutil/trace.go:171","msg":"trace[468356447] transaction","detail":"{read_only:false; response_revision:24140; number_of_response:1; }","duration":"178.674033ms","start":"2026-02-25T20:41:26.043291Z","end":"2026-02-25T20:41:26.221965Z","steps":["trace[468356447] 'process raft request'  (duration: 157.831672ms)","trace[468356447] 'compare'  (duration: 20.224915ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:26.487503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.144073ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474758 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24128 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:41:26.487879Z","caller":"traceutil/trace.go:171","msg":"trace[41676642] linearizableReadLoop","detail":"{readStateIndex:24987; appliedIndex:24983; }","duration":"195.082965ms","start":"2026-02-25T20:41:26.292777Z","end":"2026-02-25T20:41:26.48786Z","steps":["trace[41676642] 'read index received'  (duration: 63.619864ms)","trace[41676642] 'applied index is now lower than readState.Index'  (duration: 131.461951ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:26.487991Z","caller":"traceutil/trace.go:171","msg":"trace[2098280723] transaction","detail":"{read_only:false; response_revision:24144; number_of_response:1; }","duration":"234.374485ms","start":"2026-02-25T20:41:26.253606Z","end":"2026-02-25T20:41:26.48798Z","steps":["trace[2098280723] 'process raft request'  (duration: 234.20625ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:26.488028Z","caller":"traceutil/trace.go:171","msg":"trace[1616816024] transaction","detail":"{read_only:false; response_revision:24141; number_of_response:1; }","duration":"238.517196ms","start":"2026-02-25T20:41:26.249473Z","end":"2026-02-25T20:41:26.487991Z","steps":["trace[1616816024] 'process raft request'  (duration: 106.775097ms)","trace[1616816024] 'compare'  (duration: 130.713572ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:26.488035Z","caller":"traceutil/trace.go:171","msg":"trace[115521567] transaction","detail":"{read_only:false; response_revision:24142; number_of_response:1; }","duration":"237.756495ms","start":"2026-02-25T20:41:26.250241Z","end":"2026-02-25T20:41:26.487998Z","steps":["trace[115521567] 'process raft request'  (duration: 237.417726ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:26.488047Z","caller":"traceutil/trace.go:171","msg":"trace[1753736513] transaction","detail":"{read_only:false; response_revision:24143; number_of_response:1; }","duration":"234.985391ms","start":"2026-02-25T20:41:26.252993Z","end":"2026-02-25T20:41:26.487978Z","steps":["trace[1753736513] 'process raft request'  (duration: 234.755455ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:26.488174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.379454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:41:26.488211Z","caller":"traceutil/trace.go:171","msg":"trace[1665618773] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24144; }","duration":"195.558159ms","start":"2026-02-25T20:41:26.292643Z","end":"2026-02-25T20:41:26.488201Z","steps":["trace[1665618773] 'agreement among raft nodes before linearized reading'  (duration: 195.463716ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:26.488309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.993418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:41:26.488354Z","caller":"traceutil/trace.go:171","msg":"trace[656647847] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:24144; }","duration":"105.099321ms","start":"2026-02-25T20:41:26.383242Z","end":"2026-02-25T20:41:26.488341Z","steps":["trace[656647847] 'agreement among raft nodes before linearized reading'  (duration: 104.994808ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:26.703557Z","caller":"traceutil/trace.go:171","msg":"trace[333859534] transaction","detail":"{read_only:false; response_revision:24145; number_of_response:1; }","duration":"208.806925ms","start":"2026-02-25T20:41:26.494719Z","end":"2026-02-25T20:41:26.703526Z","steps":["trace[333859534] 'process raft request'  (duration: 190.509682ms)","trace[333859534] 'compare'  (duration: 18.110688ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:26.70361Z","caller":"traceutil/trace.go:171","msg":"trace[1438729226] linearizableReadLoop","detail":"{readStateIndex:24988; appliedIndex:24987; }","duration":"207.795338ms","start":"2026-02-25T20:41:26.495759Z","end":"2026-02-25T20:41:26.703554Z","steps":["trace[1438729226] 'read index received'  (duration: 189.499396ms)","trace[1438729226] 'applied index is now lower than readState.Index'  (duration: 18.294462ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:26.70394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.902842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:41:26.704077Z","caller":"traceutil/trace.go:171","msg":"trace[1586171647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24146; }","duration":"165.115328ms","start":"2026-02-25T20:41:26.538917Z","end":"2026-02-25T20:41:26.704032Z","steps":["trace[1586171647] 'agreement among raft nodes before linearized reading'  (duration: 164.899682ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:26.704149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.368763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-02-25T20:41:26.704229Z","caller":"traceutil/trace.go:171","msg":"trace[1816980122] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24146; }","duration":"208.476696ms","start":"2026-02-25T20:41:26.495735Z","end":"2026-02-25T20:41:26.704211Z","steps":["trace[1816980122] 'agreement among raft nodes before linearized reading'  (duration: 207.994763ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:26.94866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.851412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-02-25T20:41:26.948754Z","caller":"traceutil/trace.go:171","msg":"trace[528747110] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:24150; }","duration":"108.991586ms","start":"2026-02-25T20:41:26.839742Z","end":"2026-02-25T20:41:26.948734Z","steps":["trace[528747110] 'count revisions from in-memory index tree'  (duration: 108.75918ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:27.094129Z","caller":"traceutil/trace.go:171","msg":"trace[1520414084] transaction","detail":"{read_only:false; response_revision:24151; number_of_response:1; }","duration":"165.661594ms","start":"2026-02-25T20:41:26.928421Z","end":"2026-02-25T20:41:27.094083Z","steps":["trace[1520414084] 'process raft request'  (duration: 165.412557ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:28.420242Z","caller":"traceutil/trace.go:171","msg":"trace[886482814] transaction","detail":"{read_only:false; response_revision:24153; number_of_response:1; }","duration":"205.780625ms","start":"2026-02-25T20:41:28.214427Z","end":"2026-02-25T20:41:28.420208Z","steps":["trace[886482814] 'process raft request'  (duration: 108.420141ms)","trace[886482814] 'compare'  (duration: 96.924752ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:28.742068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.091183ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474794 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24141 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:41:28.742158Z","caller":"traceutil/trace.go:171","msg":"trace[2133399626] transaction","detail":"{read_only:false; response_revision:24154; number_of_response:1; }","duration":"248.33495ms","start":"2026-02-25T20:41:28.493806Z","end":"2026-02-25T20:41:28.742141Z","steps":["trace[2133399626] 'process raft request'  (duration: 101.089013ms)","trace[2133399626] 'compare'  (duration: 146.98265ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:28.802149Z","caller":"traceutil/trace.go:171","msg":"trace[517115534] linearizableReadLoop","detail":"{readStateIndex:25001; appliedIndex:24997; }","duration":"262.186853ms","start":"2026-02-25T20:41:28.539936Z","end":"2026-02-25T20:41:28.802122Z","steps":["trace[517115534] 'read index received'  (duration: 54.985111ms)","trace[517115534] 'applied index is now lower than readState.Index'  (duration: 207.200381ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:28.802219Z","caller":"traceutil/trace.go:171","msg":"trace[1882711080] transaction","detail":"{read_only:false; response_revision:24157; number_of_response:1; }","duration":"306.427184ms","start":"2026-02-25T20:41:28.495749Z","end":"2026-02-25T20:41:28.802176Z","steps":["trace[1882711080] 'process raft request'  (duration: 306.329791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:28.802317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.381337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:41:28.802365Z","caller":"traceutil/trace.go:171","msg":"trace[1196507268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24157; }","duration":"262.47016ms","start":"2026-02-25T20:41:28.539883Z","end":"2026-02-25T20:41:28.802353Z","steps":["trace[1196507268] 'agreement among raft nodes before linearized reading'  (duration: 262.394868ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:28.802178Z","caller":"traceutil/trace.go:171","msg":"trace[1026926274] transaction","detail":"{read_only:false; response_revision:24156; number_of_response:1; }","duration":"307.630107ms","start":"2026-02-25T20:41:28.494508Z","end":"2026-02-25T20:41:28.802138Z","steps":["trace[1026926274] 'process raft request'  (duration: 307.523394ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:28.802452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:28.495723Z","time spent":"306.577638ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24143 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-02-25T20:41:28.802606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:28.494484Z","time spent":"307.968806ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24144 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-02-25T20:41:28.802812Z","caller":"traceutil/trace.go:171","msg":"trace[1624276842] transaction","detail":"{read_only:false; response_revision:24155; number_of_response:1; }","duration":"308.815148ms","start":"2026-02-25T20:41:28.493937Z","end":"2026-02-25T20:41:28.802752Z","steps":["trace[1624276842] 'process raft request'  (duration: 307.932945ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:28.803095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T20:41:28.493905Z","time spent":"309.029085ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24142 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-02-25T20:41:28.833299Z","caller":"traceutil/trace.go:171","msg":"trace[106653236] transaction","detail":"{read_only:false; response_revision:24158; number_of_response:1; }","duration":"122.667534ms","start":"2026-02-25T20:41:28.710613Z","end":"2026-02-25T20:41:28.83328Z","steps":["trace[106653236] 'process raft request'  (duration: 122.447248ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:28.833596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.793752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T20:41:28.833696Z","caller":"traceutil/trace.go:171","msg":"trace[1076888364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24158; }","duration":"124.944795ms","start":"2026-02-25T20:41:28.708736Z","end":"2026-02-25T20:41:28.833681Z","steps":["trace[1076888364] 'agreement among raft nodes before linearized reading'  (duration: 124.692559ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:28.83374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.476864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-9rmwp\" ","response":"range_response_count:1 size:9709"}
{"level":"info","ts":"2026-02-25T20:41:28.83391Z","caller":"traceutil/trace.go:171","msg":"trace[1235559379] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-9rmwp; range_end:; response_count:1; response_revision:24158; }","duration":"101.751872ms","start":"2026-02-25T20:41:28.732113Z","end":"2026-02-25T20:41:28.833864Z","steps":["trace[1235559379] 'agreement among raft nodes before linearized reading'  (duration: 101.413592ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:28.834009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.392376ms","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-02-25T20:41:28.834078Z","caller":"traceutil/trace.go:171","msg":"trace[1738450829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24158; }","duration":"106.461808ms","start":"2026-02-25T20:41:28.727605Z","end":"2026-02-25T20:41:28.834066Z","steps":["trace[1738450829] 'agreement among raft nodes before linearized reading'  (duration: 106.228051ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:29.086143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.27889ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555474802 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/magnum-api-7c4f68d846-rmkwv.189797ee74c7f436\" mod_revision:24095 > success:<request_put:<key:\"/registry/events/openstack/magnum-api-7c4f68d846-rmkwv.189797ee74c7f436\" value_size:677 lease:7371157384700698478 >> failure:<request_range:<key:\"/registry/events/openstack/magnum-api-7c4f68d846-rmkwv.189797ee74c7f436\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-25T20:41:29.086422Z","caller":"traceutil/trace.go:171","msg":"trace[554350194] linearizableReadLoop","detail":"{readStateIndex:25003; appliedIndex:25002; }","duration":"247.833698ms","start":"2026-02-25T20:41:28.838571Z","end":"2026-02-25T20:41:29.086405Z","steps":["trace[554350194] 'read index received'  (duration: 68.238899ms)","trace[554350194] 'applied index is now lower than readState.Index'  (duration: 179.593149ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:29.086508Z","caller":"traceutil/trace.go:171","msg":"trace[1414380033] transaction","detail":"{read_only:false; response_revision:24159; number_of_response:1; }","duration":"248.877155ms","start":"2026-02-25T20:41:28.837568Z","end":"2026-02-25T20:41:29.086445Z","steps":["trace[1414380033] 'process raft request'  (duration: 69.169704ms)","trace[1414380033] 'compare'  (duration: 179.138206ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T20:41:29.087945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.296556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:135 size:1324956"}
{"level":"info","ts":"2026-02-25T20:41:29.08808Z","caller":"traceutil/trace.go:171","msg":"trace[1478597127] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:135; response_revision:24159; }","duration":"249.540902ms","start":"2026-02-25T20:41:28.838502Z","end":"2026-02-25T20:41:29.088043Z","steps":["trace[1478597127] 'agreement among raft nodes before linearized reading'  (duration: 247.986181ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:29.091769Z","caller":"traceutil/trace.go:171","msg":"trace[1001539041] transaction","detail":"{read_only:false; response_revision:24162; number_of_response:1; }","duration":"251.057454ms","start":"2026-02-25T20:41:28.840703Z","end":"2026-02-25T20:41:29.091761Z","steps":["trace[1001539041] 'process raft request'  (duration: 251.002102ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:29.091816Z","caller":"traceutil/trace.go:171","msg":"trace[98028274] transaction","detail":"{read_only:false; response_revision:24160; number_of_response:1; }","duration":"252.362478ms","start":"2026-02-25T20:41:28.839418Z","end":"2026-02-25T20:41:29.091781Z","steps":["trace[98028274] 'process raft request'  (duration: 252.0503ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:29.091871Z","caller":"traceutil/trace.go:171","msg":"trace[1621768674] transaction","detail":"{read_only:false; response_revision:24161; number_of_response:1; }","duration":"252.383529ms","start":"2026-02-25T20:41:28.839459Z","end":"2026-02-25T20:41:29.091843Z","steps":["trace[1621768674] 'process raft request'  (duration: 252.199244ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:29.092049Z","caller":"traceutil/trace.go:171","msg":"trace[1917691994] transaction","detail":"{read_only:false; response_revision:24163; number_of_response:1; }","duration":"241.29076ms","start":"2026-02-25T20:41:28.850746Z","end":"2026-02-25T20:41:29.092037Z","steps":["trace[1917691994] 'process raft request'  (duration: 240.988112ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:29.09213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.596646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumetypes/\" range_end:\"/registry/openstack.k-orc.cloud/volumetypes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-02-25T20:41:29.092185Z","caller":"traceutil/trace.go:171","msg":"trace[2140999360] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumetypes/; range_end:/registry/openstack.k-orc.cloud/volumetypes0; response_count:0; response_revision:24164; }","duration":"180.695169ms","start":"2026-02-25T20:41:28.911474Z","end":"2026-02-25T20:41:29.09217Z","steps":["trace[2140999360] 'agreement among raft nodes before linearized reading'  (duration: 180.583306ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:29.092406Z","caller":"traceutil/trace.go:171","msg":"trace[715403815] transaction","detail":"{read_only:false; response_revision:24164; number_of_response:1; }","duration":"241.523306ms","start":"2026-02-25T20:41:28.850741Z","end":"2026-02-25T20:41:29.092264Z","steps":["trace[715403815] 'process raft request'  (duration: 241.191268ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:29.093282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.046736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:135 size:1324956"}
{"level":"info","ts":"2026-02-25T20:41:29.093348Z","caller":"traceutil/trace.go:171","msg":"trace[1536224705] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:135; response_revision:24164; }","duration":"237.146528ms","start":"2026-02-25T20:41:28.856188Z","end":"2026-02-25T20:41:29.093335Z","steps":["trace[1536224705] 'agreement among raft nodes before linearized reading'  (duration: 235.829393ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:29.973976Z","caller":"traceutil/trace.go:171","msg":"trace[77733697] linearizableReadLoop","detail":"{readStateIndex:25011; appliedIndex:25010; }","duration":"112.546353ms","start":"2026-02-25T20:41:29.861397Z","end":"2026-02-25T20:41:29.973944Z","steps":["trace[77733697] 'read index received'  (duration: 112.251704ms)","trace[77733697] 'applied index is now lower than readState.Index'  (duration: 293.319µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:29.974105Z","caller":"traceutil/trace.go:171","msg":"trace[259321281] transaction","detail":"{read_only:false; response_revision:24167; number_of_response:1; }","duration":"212.398442ms","start":"2026-02-25T20:41:29.761652Z","end":"2026-02-25T20:41:29.974051Z","steps":["trace[259321281] 'process raft request'  (duration: 212.090903ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:29.974208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.786189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-02-25T20:41:29.974307Z","caller":"traceutil/trace.go:171","msg":"trace[1645032892] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:24167; }","duration":"112.961424ms","start":"2026-02-25T20:41:29.861325Z","end":"2026-02-25T20:41:29.974286Z","steps":["trace[1645032892] 'agreement among raft nodes before linearized reading'  (duration: 112.735558ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:30.951088Z","caller":"traceutil/trace.go:171","msg":"trace[1025689834] transaction","detail":"{read_only:false; response_revision:24170; number_of_response:1; }","duration":"143.517366ms","start":"2026-02-25T20:41:30.807538Z","end":"2026-02-25T20:41:30.951056Z","steps":["trace[1025689834] 'process raft request'  (duration: 143.179887ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:30.951096Z","caller":"traceutil/trace.go:171","msg":"trace[644499601] transaction","detail":"{read_only:false; response_revision:24171; number_of_response:1; }","duration":"142.566581ms","start":"2026-02-25T20:41:30.808495Z","end":"2026-02-25T20:41:30.951061Z","steps":["trace[644499601] 'process raft request'  (duration: 142.462128ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:30.951269Z","caller":"traceutil/trace.go:171","msg":"trace[1735995870] transaction","detail":"{read_only:false; response_revision:24172; number_of_response:1; }","duration":"141.836941ms","start":"2026-02-25T20:41:30.809394Z","end":"2026-02-25T20:41:30.951231Z","steps":["trace[1735995870] 'process raft request'  (duration: 141.613345ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T20:41:30.962601Z","caller":"traceutil/trace.go:171","msg":"trace[2067500151] linearizableReadLoop","detail":"{readStateIndex:25017; appliedIndex:25013; }","duration":"104.952857ms","start":"2026-02-25T20:41:30.857632Z","end":"2026-02-25T20:41:30.962585Z","steps":["trace[2067500151] 'read index received'  (duration: 93.105998ms)","trace[2067500151] 'applied index is now lower than readState.Index'  (duration: 11.846059ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T20:41:30.962816Z","caller":"traceutil/trace.go:171","msg":"trace[486448715] transaction","detail":"{read_only:false; response_revision:24173; number_of_response:1; }","duration":"123.024844ms","start":"2026-02-25T20:41:30.839777Z","end":"2026-02-25T20:41:30.962801Z","steps":["trace[486448715] 'process raft request'  (duration: 122.674304ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:41:30.963087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.435011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:275671"}
{"level":"info","ts":"2026-02-25T20:41:30.963136Z","caller":"traceutil/trace.go:171","msg":"trace[1286586237] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:24173; }","duration":"105.539864ms","start":"2026-02-25T20:41:30.857584Z","end":"2026-02-25T20:41:30.963124Z","steps":["trace[1286586237] 'agreement among raft nodes before linearized reading'  (duration: 105.06724ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T20:45:08.309595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.340028ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529421555480699 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:664b9c965a95387a>","response":"size:42"}
{"level":"info","ts":"2026-02-25T20:45:44.967507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23756}
{"level":"info","ts":"2026-02-25T20:45:45.114531Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23756,"took":"141.181423ms","hash":1270338882,"current-db-size-bytes":50249728,"current-db-size":"50 MB","current-db-size-in-use-bytes":34422784,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-02-25T20:45:45.114606Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1270338882,"revision":23756,"compact-revision":20514}
{"level":"info","ts":"2026-02-25T20:50:44.976567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26613}
{"level":"info","ts":"2026-02-25T20:50:45.10649Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26613,"took":"124.226307ms","hash":555129040,"current-db-size-bytes":50249728,"current-db-size":"50 MB","current-db-size-in-use-bytes":29765632,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-02-25T20:50:45.106565Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":555129040,"revision":26613,"compact-revision":23756}
{"level":"info","ts":"2026-02-25T20:51:30.792479Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-02-25T20:51:30.79949Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-02-25T20:51:30.79961Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-02-25T20:55:44.984462Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28695}
{"level":"info","ts":"2026-02-25T20:55:45.108075Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28695,"took":"118.72813ms","hash":3471359456,"current-db-size-bytes":50249728,"current-db-size":"50 MB","current-db-size-in-use-bytes":27557888,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-02-25T20:55:45.10816Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3471359456,"revision":28695,"compact-revision":26613}
{"level":"info","ts":"2026-02-25T21:00:44.994337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30813}
{"level":"info","ts":"2026-02-25T21:00:45.127147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30813,"took":"126.92455ms","hash":1689813426,"current-db-size-bytes":50249728,"current-db-size":"50 MB","current-db-size-in-use-bytes":28839936,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-02-25T21:00:45.127205Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1689813426,"revision":30813,"compact-revision":28695}
{"level":"info","ts":"2026-02-25T21:05:45.001524Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33006}
{"level":"info","ts":"2026-02-25T21:05:45.14715Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33006,"took":"140.079555ms","hash":3314134775,"current-db-size-bytes":51159040,"current-db-size":"51 MB","current-db-size-in-use-bytes":28372992,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-02-25T21:05:45.147224Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3314134775,"revision":33006,"compact-revision":30813}