{"level":"warn","ts":"2026-09-11T17:40:16.852436Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-11T17:40:16.852735Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.28: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.28:2380","--initial-cluster=instance=https://162.253.55.28:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.28:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.28:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-09-11T17:40:16.852836Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-11T17:40:16.852856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.28:2380"]}
{"level":"info","ts":"2026-09-11T17:40:16.8529Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-11T17:40:16.853876Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.28:2379"]}
{"level":"info","ts":"2026-09-11T17:40:16.853975Z","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.28:2380"],"listen-peer-urls":["https://162.253.55.28:2380"],"advertise-client-urls":["https://162.253.55.28:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.28:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.28:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-09-11T17:40:16.857513Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.238631ms"}
{"level":"info","ts":"2026-09-11T17:40:16.866516Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"328ca0518abde8c2","cluster-id":"3b57b7d6a07cbbf8"}
{"level":"info","ts":"2026-09-11T17:40:16.866646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-11T17:40:16.866705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 became follower at term 0"}
{"level":"info","ts":"2026-09-11T17:40:16.866722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 328ca0518abde8c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-11T17:40:16.86674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 became follower at term 1"}
{"level":"info","ts":"2026-09-11T17:40:16.867054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 switched to configuration voters=(3642462470716385474)"}
{"level":"warn","ts":"2026-09-11T17:40:16.878097Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-11T17:40:16.880751Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-11T17:40:16.884654Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-09-11T17:40:16.889403Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"328ca0518abde8c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-11T17:40:16.88962Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-11T17:40:16.889739Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-11T17:40:16.889756Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-11T17:40:16.890082Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"328ca0518abde8c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-11T17:40:16.89201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 switched to configuration voters=(3642462470716385474)"}
{"level":"info","ts":"2026-09-11T17:40:16.892187Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3b57b7d6a07cbbf8","local-member-id":"328ca0518abde8c2","added-peer-id":"328ca0518abde8c2","added-peer-peer-urls":["https://162.253.55.28:2380"]}
{"level":"info","ts":"2026-09-11T17:40:16.894791Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-11T17:40:16.894961Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.28:2380"}
{"level":"info","ts":"2026-09-11T17:40:16.895117Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.28:2380"}
{"level":"info","ts":"2026-09-11T17:40:16.895237Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"328ca0518abde8c2","initial-advertise-peer-urls":["https://162.253.55.28:2380"],"listen-peer-urls":["https://162.253.55.28:2380"],"advertise-client-urls":["https://162.253.55.28:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.28:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-11T17:40:16.895321Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-11T17:40:17.568518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-11T17:40:17.568585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-11T17:40:17.568619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 received MsgPreVoteResp from 328ca0518abde8c2 at term 1"}
{"level":"info","ts":"2026-09-11T17:40:17.568639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 became candidate at term 2"}
{"level":"info","ts":"2026-09-11T17:40:17.56865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 received MsgVoteResp from 328ca0518abde8c2 at term 2"}
{"level":"info","ts":"2026-09-11T17:40:17.568665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"328ca0518abde8c2 became leader at term 2"}
{"level":"info","ts":"2026-09-11T17:40:17.568703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 328ca0518abde8c2 elected leader 328ca0518abde8c2 at term 2"}
{"level":"info","ts":"2026-09-11T17:40:17.574025Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"328ca0518abde8c2","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.28:2379]}","request-path":"/0/members/328ca0518abde8c2/attributes","cluster-id":"3b57b7d6a07cbbf8","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-11T17:40:17.574052Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-11T17:40:17.574015Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-11T17:40:17.574107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-11T17:40:17.574395Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-11T17:40:17.574455Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-11T17:40:17.578115Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3b57b7d6a07cbbf8","local-member-id":"328ca0518abde8c2","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-11T17:40:17.578326Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-11T17:40:17.578396Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-11T17:40:17.579324Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-11T17:40:17.57932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.28:2379"}
{"level":"info","ts":"2026-09-11T17:40:33.371783Z","caller":"traceutil/trace.go:171","msg":"trace[1161100582] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"104.580675ms","start":"2026-09-11T17:40:33.267162Z","end":"2026-09-11T17:40:33.371742Z","steps":["trace[1161100582] 'process raft request'  (duration: 104.318368ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:40:33.797775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.122677ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299156627 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:411 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7029 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-11T17:40:33.798153Z","caller":"traceutil/trace.go:171","msg":"trace[332047697] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"163.887002ms","start":"2026-09-11T17:40:33.634186Z","end":"2026-09-11T17:40:33.798073Z","steps":["trace[332047697] 'process raft request'  (duration: 163.743939ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:40:33.798375Z","caller":"traceutil/trace.go:171","msg":"trace[2023906578] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"247.463913ms","start":"2026-09-11T17:40:33.550805Z","end":"2026-09-11T17:40:33.798269Z","steps":["trace[2023906578] 'read index received'  (duration: 28.060368ms)","trace[2023906578] 'applied index is now lower than readState.Index'  (duration: 219.393125ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:40:33.798429Z","caller":"traceutil/trace.go:171","msg":"trace[840283764] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"410.65852ms","start":"2026-09-11T17:40:33.387726Z","end":"2026-09-11T17:40:33.798384Z","steps":["trace[840283764] 'process raft request'  (duration: 191.207853ms)","trace[840283764] 'compare'  (duration: 217.879532ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:40:33.798543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.726269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-11T17:40:33.798636Z","caller":"traceutil/trace.go:171","msg":"trace[1442087434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"247.939344ms","start":"2026-09-11T17:40:33.550676Z","end":"2026-09-11T17:40:33.798615Z","steps":["trace[1442087434] 'agreement among raft nodes before linearized reading'  (duration: 247.77856ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:40:33.79876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:40:33.387677Z","time spent":"410.934605ms","remote":"127.0.0.1:39520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:411 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7029 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-09-11T17:40:33.798813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.371654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-11T17:40:33.798846Z","caller":"traceutil/trace.go:171","msg":"trace[1855375235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"239.460635ms","start":"2026-09-11T17:40:33.559378Z","end":"2026-09-11T17:40:33.798838Z","steps":["trace[1855375235] 'agreement among raft nodes before linearized reading'  (duration: 239.376564ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:41:02.81986Z","caller":"traceutil/trace.go:171","msg":"trace[812389237] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"102.961019ms","start":"2026-09-11T17:41:02.716881Z","end":"2026-09-11T17:41:02.819842Z","steps":["trace[812389237] 'process raft request'  (duration: 102.220592ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:41:02.81998Z","caller":"traceutil/trace.go:171","msg":"trace[1095443636] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"103.211754ms","start":"2026-09-11T17:41:02.716763Z","end":"2026-09-11T17:41:02.819974Z","steps":["trace[1095443636] 'process raft request'  (duration: 102.436196ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:41:03.160847Z","caller":"traceutil/trace.go:171","msg":"trace[148970220] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"130.778981ms","start":"2026-09-11T17:41:03.030022Z","end":"2026-09-11T17:41:03.160801Z","steps":["trace[148970220] 'process raft request'  (duration: 98.618123ms)","trace[148970220] 'compare'  (duration: 31.875282ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:41:03.160989Z","caller":"traceutil/trace.go:171","msg":"trace[2020105080] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"124.105294ms","start":"2026-09-11T17:41:03.036838Z","end":"2026-09-11T17:41:03.160944Z","steps":["trace[2020105080] 'process raft request'  (duration: 123.832778ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:41:09.513849Z","caller":"traceutil/trace.go:171","msg":"trace[998720144] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"161.974509ms","start":"2026-09-11T17:41:09.351816Z","end":"2026-09-11T17:41:09.513791Z","steps":["trace[998720144] 'process raft request'  (duration: 101.513507ms)","trace[998720144] 'compare'  (duration: 60.033283ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:41:10.03515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.474033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:41:10.035295Z","caller":"traceutil/trace.go:171","msg":"trace[321934575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"360.684027ms","start":"2026-09-11T17:41:09.674578Z","end":"2026-09-11T17:41:10.035262Z","steps":["trace[321934575] 'range keys from in-memory index tree'  (duration: 360.285138ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:41:10.035355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:41:09.674543Z","time spent":"360.79823ms","remote":"127.0.0.1:39332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-11T17:41:10.0357Z","caller":"traceutil/trace.go:171","msg":"trace[1027911740] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"137.433718ms","start":"2026-09-11T17:41:09.898236Z","end":"2026-09-11T17:41:10.03567Z","steps":["trace[1027911740] 'process raft request'  (duration: 135.342223ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:41:26.39783Z","caller":"traceutil/trace.go:171","msg":"trace[678509357] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"147.288474ms","start":"2026-09-11T17:41:26.250464Z","end":"2026-09-11T17:41:26.397753Z","steps":["trace[678509357] 'process raft request'  (duration: 147.214503ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:41:26.397839Z","caller":"traceutil/trace.go:171","msg":"trace[1313520626] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"147.343806ms","start":"2026-09-11T17:41:26.250443Z","end":"2026-09-11T17:41:26.397786Z","steps":["trace[1313520626] 'process raft request'  (duration: 147.103001ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:18.0148Z","caller":"traceutil/trace.go:171","msg":"trace[950165096] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"109.755622ms","start":"2026-09-11T17:42:17.90497Z","end":"2026-09-11T17:42:18.014726Z","steps":["trace[950165096] 'process raft request'  (duration: 93.726968ms)","trace[950165096] 'compare'  (duration: 15.84132ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:42:42.031564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.658473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-09-11T17:42:42.031631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.581713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-11T17:42:42.031675Z","caller":"traceutil/trace.go:171","msg":"trace[2131939513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1892; }","duration":"202.820417ms","start":"2026-09-11T17:42:41.828821Z","end":"2026-09-11T17:42:42.031642Z","steps":["trace[2131939513] 'range keys from in-memory index tree'  (duration: 202.456458ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.031727Z","caller":"traceutil/trace.go:171","msg":"trace[1378750322] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1892; }","duration":"203.733507ms","start":"2026-09-11T17:42:41.827971Z","end":"2026-09-11T17:42:42.031705Z","steps":["trace[1378750322] 'range keys from in-memory index tree'  (duration: 203.342959ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.047321Z","caller":"traceutil/trace.go:171","msg":"trace[1626361222] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"136.993463ms","start":"2026-09-11T17:42:41.910298Z","end":"2026-09-11T17:42:42.047291Z","steps":["trace[1626361222] 'process raft request'  (duration: 136.758208ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.157852Z","caller":"traceutil/trace.go:171","msg":"trace[1776119601] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"123.962794ms","start":"2026-09-11T17:42:42.033857Z","end":"2026-09-11T17:42:42.15782Z","steps":["trace[1776119601] 'process raft request'  (duration: 123.833961ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.157873Z","caller":"traceutil/trace.go:171","msg":"trace[1284962866] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"231.849932ms","start":"2026-09-11T17:42:41.925981Z","end":"2026-09-11T17:42:42.157831Z","steps":["trace[1284962866] 'process raft request'  (duration: 209.26489ms)","trace[1284962866] 'compare'  (duration: 22.289416ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:42:42.158374Z","caller":"traceutil/trace.go:171","msg":"trace[507797130] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"122.00195ms","start":"2026-09-11T17:42:42.036338Z","end":"2026-09-11T17:42:42.15834Z","steps":["trace[507797130] 'process raft request'  (duration: 121.403147ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.158419Z","caller":"traceutil/trace.go:171","msg":"trace[157621995] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"120.983828ms","start":"2026-09-11T17:42:42.037411Z","end":"2026-09-11T17:42:42.158394Z","steps":["trace[157621995] 'process raft request'  (duration: 120.707402ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.158344Z","caller":"traceutil/trace.go:171","msg":"trace[843471571] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1963; }","duration":"204.409861ms","start":"2026-09-11T17:42:41.953896Z","end":"2026-09-11T17:42:42.158306Z","steps":["trace[843471571] 'read index received'  (duration: 93.150269ms)","trace[843471571] 'applied index is now lower than readState.Index'  (duration: 111.257962ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:42:42.158634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.703679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"}
{"level":"info","ts":"2026-09-11T17:42:42.158692Z","caller":"traceutil/trace.go:171","msg":"trace[36050350] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1897; }","duration":"204.834691ms","start":"2026-09-11T17:42:41.953844Z","end":"2026-09-11T17:42:42.158678Z","steps":["trace[36050350] 'agreement among raft nodes before linearized reading'  (duration: 204.589995ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:42.447718Z","caller":"traceutil/trace.go:171","msg":"trace[1879680777] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1968; }","duration":"253.993584ms","start":"2026-09-11T17:42:42.193701Z","end":"2026-09-11T17:42:42.447695Z","steps":["trace[1879680777] 'read index received'  (duration: 253.089663ms)","trace[1879680777] 'applied index is now lower than readState.Index'  (duration: 902.761µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:42:42.447811Z","caller":"traceutil/trace.go:171","msg":"trace[997759251] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"274.095439ms","start":"2026-09-11T17:42:42.17368Z","end":"2026-09-11T17:42:42.447775Z","steps":["trace[997759251] 'process raft request'  (duration: 273.178398ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:42:42.448255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.527115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18d45522b81a8c9a\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-09-11T17:42:42.448385Z","caller":"traceutil/trace.go:171","msg":"trace[99594699] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18d45522b81a8c9a; range_end:; response_count:1; response_revision:1898; }","duration":"254.714589ms","start":"2026-09-11T17:42:42.193646Z","end":"2026-09-11T17:42:42.44836Z","steps":["trace[99594699] 'agreement among raft nodes before linearized reading'  (duration: 254.413213ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:42:55.066855Z","caller":"traceutil/trace.go:171","msg":"trace[1598175690] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"108.290566ms","start":"2026-09-11T17:42:54.958528Z","end":"2026-09-11T17:42:55.066819Z","steps":["trace[1598175690] 'process raft request'  (duration: 92.006645ms)","trace[1598175690] 'compare'  (duration: 16.070897ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:42:55.223976Z","caller":"traceutil/trace.go:171","msg":"trace[1969549206] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"141.232198ms","start":"2026-09-11T17:42:55.08271Z","end":"2026-09-11T17:42:55.223942Z","steps":["trace[1969549206] 'process raft request'  (duration: 109.112454ms)","trace[1969549206] 'compare'  (duration: 31.733405ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:43:31.678247Z","caller":"traceutil/trace.go:171","msg":"trace[1763741955] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2301; }","duration":"205.24162ms","start":"2026-09-11T17:43:31.472971Z","end":"2026-09-11T17:43:31.678213Z","steps":["trace[1763741955] 'read index received'  (duration: 205.047265ms)","trace[1763741955] 'applied index is now lower than readState.Index'  (duration: 193.225µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:43:31.678402Z","caller":"traceutil/trace.go:171","msg":"trace[2022611942] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"327.186369ms","start":"2026-09-11T17:43:31.351201Z","end":"2026-09-11T17:43:31.678387Z","steps":["trace[2022611942] 'process raft request'  (duration: 326.845871ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:43:31.678527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:43:31.351182Z","time spent":"327.254322ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2209 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-11T17:43:31.678944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.922924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-09-11T17:43:31.679108Z","caller":"traceutil/trace.go:171","msg":"trace[2035272990] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2220; }","duration":"206.14909ms","start":"2026-09-11T17:43:31.472924Z","end":"2026-09-11T17:43:31.679074Z","steps":["trace[2035272990] 'agreement among raft nodes before linearized reading'  (duration: 205.684649ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:43:32.021314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.183116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299160299 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:2140 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-11T17:43:32.021483Z","caller":"traceutil/trace.go:171","msg":"trace[707069747] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"337.227893ms","start":"2026-09-11T17:43:31.684229Z","end":"2026-09-11T17:43:32.021456Z","steps":["trace[707069747] 'process raft request'  (duration: 87.7304ms)","trace[707069747] 'compare'  (duration: 248.983312ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:43:32.021557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:43:31.68421Z","time spent":"337.316065ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:2140 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-09-11T17:43:38.236618Z","caller":"traceutil/trace.go:171","msg":"trace[1156699177] linearizableReadLoop","detail":"{readStateIndex:2336; appliedIndex:2335; }","duration":"118.225276ms","start":"2026-09-11T17:43:38.11837Z","end":"2026-09-11T17:43:38.236595Z","steps":["trace[1156699177] 'read index received'  (duration: 118.088403ms)","trace[1156699177] 'applied index is now lower than readState.Index'  (duration: 133.883µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:43:38.236652Z","caller":"traceutil/trace.go:171","msg":"trace[1286859052] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"127.569654ms","start":"2026-09-11T17:43:38.109065Z","end":"2026-09-11T17:43:38.236634Z","steps":["trace[1286859052] 'process raft request'  (duration: 127.37378ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:43:38.23675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.43701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:43:38.236798Z","caller":"traceutil/trace.go:171","msg":"trace[1043718712] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2253; }","duration":"104.540483ms","start":"2026-09-11T17:43:38.132247Z","end":"2026-09-11T17:43:38.236788Z","steps":["trace[1043718712] 'agreement among raft nodes before linearized reading'  (duration: 104.454891ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:43:38.237157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.510233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-11T17:43:38.237248Z","caller":"traceutil/trace.go:171","msg":"trace[148876585] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2253; }","duration":"118.877562ms","start":"2026-09-11T17:43:38.118356Z","end":"2026-09-11T17:43:38.237234Z","steps":["trace[148876585] 'agreement among raft nodes before linearized reading'  (duration: 118.336289ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:43:38.528612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.154093ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299160377 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2244 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-11T17:43:38.528982Z","caller":"traceutil/trace.go:171","msg":"trace[1892717659] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"285.460573ms","start":"2026-09-11T17:43:38.243501Z","end":"2026-09-11T17:43:38.528962Z","steps":["trace[1892717659] 'process raft request'  (duration: 122.884481ms)","trace[1892717659] 'compare'  (duration: 162.01465ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:44:55.031328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.369561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-11T17:44:55.031441Z","caller":"traceutil/trace.go:171","msg":"trace[1240836581] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2864; }","duration":"105.571766ms","start":"2026-09-11T17:44:54.925847Z","end":"2026-09-11T17:44:55.031419Z","steps":["trace[1240836581] 'range keys from in-memory index tree'  (duration: 105.095495ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:49:28.454885Z","caller":"traceutil/trace.go:171","msg":"trace[1058530437] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"191.481139ms","start":"2026-09-11T17:49:28.263377Z","end":"2026-09-11T17:49:28.454858Z","steps":["trace[1058530437] 'process raft request'  (duration: 191.343436ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:49:32.338735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.658245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:49:32.338952Z","caller":"traceutil/trace.go:171","msg":"trace[1849129390] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:5269; }","duration":"108.967173ms","start":"2026-09-11T17:49:32.229959Z","end":"2026-09-11T17:49:32.338926Z","steps":["trace[1849129390] 'count revisions from in-memory index tree'  (duration: 108.508862ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:49:32.346854Z","caller":"traceutil/trace.go:171","msg":"trace[1417404816] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"113.287018ms","start":"2026-09-11T17:49:32.233532Z","end":"2026-09-11T17:49:32.346819Z","steps":["trace[1417404816] 'process raft request'  (duration: 113.115734ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:49:46.20376Z","caller":"traceutil/trace.go:171","msg":"trace[129397516] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"212.490835ms","start":"2026-09-11T17:49:45.991224Z","end":"2026-09-11T17:49:46.203715Z","steps":["trace[129397516] 'process raft request'  (duration: 174.095444ms)","trace[129397516] 'compare'  (duration: 38.178206ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:49:54.740457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.972293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:49:54.740548Z","caller":"traceutil/trace.go:171","msg":"trace[1947514547] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5698; }","duration":"338.097595ms","start":"2026-09-11T17:49:54.402429Z","end":"2026-09-11T17:49:54.740526Z","steps":["trace[1947514547] 'range keys from in-memory index tree'  (duration: 337.901231ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:49:54.740591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:49:54.402413Z","time spent":"338.168097ms","remote":"127.0.0.1:39734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-09-11T17:49:54.741208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.160257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-09-11T17:49:54.741296Z","caller":"traceutil/trace.go:171","msg":"trace[1286425439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5698; }","duration":"217.268031ms","start":"2026-09-11T17:49:54.524003Z","end":"2026-09-11T17:49:54.741271Z","steps":["trace[1286425439] 'range keys from in-memory index tree'  (duration: 216.900892ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:49:54.741196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.968495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-144e5134-0216-4146-b233-60fda4e4c8b9\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-09-11T17:49:54.741581Z","caller":"traceutil/trace.go:171","msg":"trace[400164268] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-144e5134-0216-4146-b233-60fda4e4c8b9; range_end:; response_count:1; response_revision:5698; }","duration":"241.351154ms","start":"2026-09-11T17:49:54.500119Z","end":"2026-09-11T17:49:54.74147Z","steps":["trace[400164268] 'range keys from in-memory index tree'  (duration: 240.744721ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:49:54.821235Z","caller":"traceutil/trace.go:171","msg":"trace[1437440976] transaction","detail":"{read_only:false; response_revision:5699; number_of_response:1; }","duration":"125.875487ms","start":"2026-09-11T17:49:54.69534Z","end":"2026-09-11T17:49:54.821215Z","steps":["trace[1437440976] 'process raft request'  (duration: 125.620372ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:49:54.821494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.652498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-11T17:49:54.821579Z","caller":"traceutil/trace.go:171","msg":"trace[1334825648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5699; }","duration":"109.78144ms","start":"2026-09-11T17:49:54.711783Z","end":"2026-09-11T17:49:54.821564Z","steps":["trace[1334825648] 'agreement among raft nodes before linearized reading'  (duration: 109.592746ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:49:54.82182Z","caller":"traceutil/trace.go:171","msg":"trace[678388221] linearizableReadLoop","detail":"{readStateIndex:5908; appliedIndex:5907; }","duration":"109.32153ms","start":"2026-09-11T17:49:54.711829Z","end":"2026-09-11T17:49:54.82115Z","steps":["trace[678388221] 'read index received'  (duration: 109.036194ms)","trace[678388221] 'applied index is now lower than readState.Index'  (duration: 284.166µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:49:54.980698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.880789ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299168598 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5612 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-11T17:49:54.980891Z","caller":"traceutil/trace.go:171","msg":"trace[1402437078] transaction","detail":"{read_only:false; response_revision:5701; number_of_response:1; }","duration":"155.654687ms","start":"2026-09-11T17:49:54.82522Z","end":"2026-09-11T17:49:54.980874Z","steps":["trace[1402437078] 'process raft request'  (duration: 155.570795ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:49:54.980899Z","caller":"traceutil/trace.go:171","msg":"trace[361639711] transaction","detail":"{read_only:false; response_revision:5700; number_of_response:1; }","duration":"236.017966ms","start":"2026-09-11T17:49:54.74485Z","end":"2026-09-11T17:49:54.980868Z","steps":["trace[361639711] 'process raft request'  (duration: 132.756699ms)","trace[361639711] 'compare'  (duration: 102.739476ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:49:54.980898Z","caller":"traceutil/trace.go:171","msg":"trace[469131793] linearizableReadLoop","detail":"{readStateIndex:5909; appliedIndex:5908; }","duration":"158.914519ms","start":"2026-09-11T17:49:54.82195Z","end":"2026-09-11T17:49:54.980865Z","steps":["trace[469131793] 'read index received'  (duration: 55.671893ms)","trace[469131793] 'applied index is now lower than readState.Index'  (duration: 103.239206ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:49:54.981102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.076994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:49:54.98122Z","caller":"traceutil/trace.go:171","msg":"trace[1032122763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5701; }","duration":"239.233067ms","start":"2026-09-11T17:49:54.74197Z","end":"2026-09-11T17:49:54.981203Z","steps":["trace[1032122763] 'agreement among raft nodes before linearized reading'  (duration: 239.070834ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:49:54.981126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.880715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:49:54.981373Z","caller":"traceutil/trace.go:171","msg":"trace[1684228758] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5701; }","duration":"237.168441ms","start":"2026-09-11T17:49:54.744192Z","end":"2026-09-11T17:49:54.981361Z","steps":["trace[1684228758] 'agreement among raft nodes before linearized reading'  (duration: 236.813263ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:49:54.981143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.68217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T17:49:54.981493Z","caller":"traceutil/trace.go:171","msg":"trace[1708271904] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5701; }","duration":"111.047919ms","start":"2026-09-11T17:49:54.870398Z","end":"2026-09-11T17:49:54.981445Z","steps":["trace[1708271904] 'agreement among raft nodes before linearized reading'  (duration: 110.67187ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:50:17.610252Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989}
{"level":"info","ts":"2026-09-11T17:50:17.705481Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"93.738335ms","hash":2062632257,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":32522240,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-11T17:50:17.705549Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2062632257,"revision":2989,"compact-revision":-1}
{"level":"info","ts":"2026-09-11T17:55:17.617142Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5917}
{"level":"info","ts":"2026-09-11T17:55:17.705428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5917,"took":"86.323601ms","hash":2706387674,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":26808320,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-11T17:55:17.705501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2706387674,"revision":5917,"compact-revision":2989}
{"level":"info","ts":"2026-09-11T17:56:15.855953Z","caller":"traceutil/trace.go:171","msg":"trace[869816523] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"352.1602ms","start":"2026-09-11T17:56:15.50377Z","end":"2026-09-11T17:56:15.85593Z","steps":["trace[869816523] 'process raft request'  (duration: 352.026497ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:15.856103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:56:15.503739Z","time spent":"352.292853ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8577 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-11T17:56:15.96122Z","caller":"traceutil/trace.go:171","msg":"trace[936542051] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"290.339224ms","start":"2026-09-11T17:56:15.670849Z","end":"2026-09-11T17:56:15.961188Z","steps":["trace[936542051] 'process raft request'  (duration: 285.206429ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:27.183434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.611267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-11T17:56:27.183524Z","caller":"traceutil/trace.go:171","msg":"trace[713188715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8647; }","duration":"106.74484ms","start":"2026-09-11T17:56:27.076761Z","end":"2026-09-11T17:56:27.183506Z","steps":["trace[713188715] 'range keys from in-memory index tree'  (duration: 106.432353ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:56:27.348965Z","caller":"traceutil/trace.go:171","msg":"trace[767320786] linearizableReadLoop","detail":"{readStateIndex:8954; appliedIndex:8953; }","duration":"125.248123ms","start":"2026-09-11T17:56:27.223682Z","end":"2026-09-11T17:56:27.34893Z","steps":["trace[767320786] 'read index received'  (duration: 124.997138ms)","trace[767320786] 'applied index is now lower than readState.Index'  (duration: 249.715µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:56:27.349333Z","caller":"traceutil/trace.go:171","msg":"trace[1911307864] transaction","detail":"{read_only:false; response_revision:8648; number_of_response:1; }","duration":"161.548193ms","start":"2026-09-11T17:56:27.187767Z","end":"2026-09-11T17:56:27.349316Z","steps":["trace[1911307864] 'process raft request'  (duration: 160.998651ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:27.349596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.866827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-11T17:56:27.349645Z","caller":"traceutil/trace.go:171","msg":"trace[795137952] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:8648; }","duration":"125.99044ms","start":"2026-09-11T17:56:27.223638Z","end":"2026-09-11T17:56:27.349628Z","steps":["trace[795137952] 'agreement among raft nodes before linearized reading'  (duration: 125.868847ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:27.349912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.929493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-11T17:56:27.349955Z","caller":"traceutil/trace.go:171","msg":"trace[1642024556] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:8648; }","duration":"102.010014ms","start":"2026-09-11T17:56:27.247933Z","end":"2026-09-11T17:56:27.349943Z","steps":["trace[1642024556] 'agreement among raft nodes before linearized reading'  (duration: 101.896002ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:56:28.032673Z","caller":"traceutil/trace.go:171","msg":"trace[2059880895] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"122.210465ms","start":"2026-09-11T17:56:27.910436Z","end":"2026-09-11T17:56:28.032647Z","steps":["trace[2059880895] 'process raft request'  (duration: 122.049392ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:56:28.1066Z","caller":"traceutil/trace.go:171","msg":"trace[1496001221] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"108.95264ms","start":"2026-09-11T17:56:27.997612Z","end":"2026-09-11T17:56:28.106565Z","steps":["trace[1496001221] 'process raft request'  (duration: 101.983225ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:56:28.903724Z","caller":"traceutil/trace.go:171","msg":"trace[47643491] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"110.462463ms","start":"2026-09-11T17:56:28.793237Z","end":"2026-09-11T17:56:28.903699Z","steps":["trace[47643491] 'process raft request'  (duration: 110.242558ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:56:59.728179Z","caller":"traceutil/trace.go:171","msg":"trace[2031533262] linearizableReadLoop","detail":"{readStateIndex:9187; appliedIndex:9186; }","duration":"116.18159ms","start":"2026-09-11T17:56:59.611965Z","end":"2026-09-11T17:56:59.728146Z","steps":["trace[2031533262] 'read index received'  (duration: 116.010396ms)","trace[2031533262] 'applied index is now lower than readState.Index'  (duration: 170.084µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:56:59.728252Z","caller":"traceutil/trace.go:171","msg":"trace[548759414] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"216.135259ms","start":"2026-09-11T17:56:59.512077Z","end":"2026-09-11T17:56:59.728212Z","steps":["trace[548759414] 'process raft request'  (duration: 215.910134ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:59.72845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.465736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-11T17:56:59.728508Z","caller":"traceutil/trace.go:171","msg":"trace[1397658868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8873; }","duration":"116.573588ms","start":"2026-09-11T17:56:59.611915Z","end":"2026-09-11T17:56:59.728489Z","steps":["trace[1397658868] 'agreement among raft nodes before linearized reading'  (duration: 116.400714ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:59.893913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.926413ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299177025 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8775 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-11T17:56:59.894104Z","caller":"traceutil/trace.go:171","msg":"trace[1534577918] transaction","detail":"{read_only:false; response_revision:8874; number_of_response:1; }","duration":"249.097803ms","start":"2026-09-11T17:56:59.644983Z","end":"2026-09-11T17:56:59.894081Z","steps":["trace[1534577918] 'process raft request'  (duration: 115.843763ms)","trace[1534577918] 'compare'  (duration: 132.732499ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T17:56:59.894131Z","caller":"traceutil/trace.go:171","msg":"trace[15320893] transaction","detail":"{read_only:false; response_revision:8875; number_of_response:1; }","duration":"160.99137ms","start":"2026-09-11T17:56:59.733125Z","end":"2026-09-11T17:56:59.894116Z","steps":["trace[15320893] 'process raft request'  (duration: 160.911317ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:56:59.89426Z","caller":"traceutil/trace.go:171","msg":"trace[1416216043] linearizableReadLoop","detail":"{readStateIndex:9188; appliedIndex:9187; }","duration":"165.966981ms","start":"2026-09-11T17:56:59.728285Z","end":"2026-09-11T17:56:59.894252Z","steps":["trace[1416216043] 'read index received'  (duration: 32.542066ms)","trace[1416216043] 'applied index is now lower than readState.Index'  (duration: 133.423975ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T17:56:59.894468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.84733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-11T17:56:59.894512Z","caller":"traceutil/trace.go:171","msg":"trace[1935891800] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8875; }","duration":"114.929262ms","start":"2026-09-11T17:56:59.779571Z","end":"2026-09-11T17:56:59.894501Z","steps":["trace[1935891800] 'agreement among raft nodes before linearized reading'  (duration: 114.856951ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:59.894605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.781863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-11T17:56:59.894644Z","caller":"traceutil/trace.go:171","msg":"trace[1949612354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8875; }","duration":"255.850955ms","start":"2026-09-11T17:56:59.638783Z","end":"2026-09-11T17:56:59.894634Z","steps":["trace[1949612354] 'agreement among raft nodes before linearized reading'  (duration: 255.733603ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:56:59.89477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.765554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-11T17:56:59.894817Z","caller":"traceutil/trace.go:171","msg":"trace[928157300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8875; }","duration":"260.816405ms","start":"2026-09-11T17:56:59.63399Z","end":"2026-09-11T17:56:59.894806Z","steps":["trace[928157300] 'agreement among raft nodes before linearized reading'  (duration: 260.685672ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T17:57:07.344531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.744689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-11T17:57:07.344607Z","caller":"traceutil/trace.go:171","msg":"trace[36288318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8917; }","duration":"175.856461ms","start":"2026-09-11T17:57:07.168732Z","end":"2026-09-11T17:57:07.344588Z","steps":["trace[36288318] 'range keys from in-memory index tree'  (duration: 175.594396ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:57:07.463889Z","caller":"traceutil/trace.go:171","msg":"trace[1676330744] transaction","detail":"{read_only:false; response_revision:8918; number_of_response:1; }","duration":"115.27932ms","start":"2026-09-11T17:57:07.348581Z","end":"2026-09-11T17:57:07.46386Z","steps":["trace[1676330744] 'process raft request'  (duration: 115.131037ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T17:57:22.666551Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024af.wal"}
{"level":"info","ts":"2026-09-11T17:58:18.806344Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"328ca0518abde8c2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-11T17:58:18.814794Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-11T17:58:18.814887Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-11T18:00:17.625137Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8082}
{"level":"info","ts":"2026-09-11T18:00:17.691623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8082,"took":"64.264457ms","hash":3738292801,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":27684864,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-11T18:00:17.691743Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3738292801,"revision":8082,"compact-revision":5917}
{"level":"info","ts":"2026-09-11T18:04:18.278231Z","caller":"traceutil/trace.go:171","msg":"trace[946978490] linearizableReadLoop","detail":"{readStateIndex:12638; appliedIndex:12637; }","duration":"103.134692ms","start":"2026-09-11T18:04:18.175067Z","end":"2026-09-11T18:04:18.278202Z","steps":["trace[946978490] 'read index received'  (duration: 80.038205ms)","trace[946978490] 'applied index is now lower than readState.Index'  (duration: 23.094767ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:04:18.278574Z","caller":"traceutil/trace.go:171","msg":"trace[1239765886] transaction","detail":"{read_only:false; response_revision:12219; number_of_response:1; }","duration":"145.620034ms","start":"2026-09-11T18:04:18.132912Z","end":"2026-09-11T18:04:18.278532Z","steps":["trace[1239765886] 'process raft request'  (duration: 122.175049ms)","trace[1239765886] 'compare'  (duration: 22.891003ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:04:18.278644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.532281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-11T18:04:18.2788Z","caller":"traceutil/trace.go:171","msg":"trace[1723527563] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:12219; }","duration":"103.791436ms","start":"2026-09-11T18:04:18.174975Z","end":"2026-09-11T18:04:18.278767Z","steps":["trace[1723527563] 'agreement among raft nodes before linearized reading'  (duration: 103.420218ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:05:17.631677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10470}
{"level":"info","ts":"2026-09-11T18:05:17.712117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10470,"took":"78.114603ms","hash":2995546590,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":26071040,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-11T18:05:17.712185Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2995546590,"revision":10470,"compact-revision":8082}
{"level":"info","ts":"2026-09-11T18:10:15.239134Z","caller":"traceutil/trace.go:171","msg":"trace[1755472979] transaction","detail":"{read_only:false; response_revision:14677; number_of_response:1; }","duration":"141.41011ms","start":"2026-09-11T18:10:15.097676Z","end":"2026-09-11T18:10:15.239086Z","steps":["trace[1755472979] 'process raft request'  (duration: 133.898104ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:10:15.246813Z","caller":"traceutil/trace.go:171","msg":"trace[718730520] transaction","detail":"{read_only:false; response_revision:14678; number_of_response:1; }","duration":"143.284261ms","start":"2026-09-11T18:10:15.103493Z","end":"2026-09-11T18:10:15.246777Z","steps":["trace[718730520] 'process raft request'  (duration: 143.074167ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:10:17.643293Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12653}
{"level":"info","ts":"2026-09-11T18:10:17.727696Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12653,"took":"81.903854ms","hash":1917158583,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":28221440,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-11T18:10:17.727773Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1917158583,"revision":12653,"compact-revision":10470}
{"level":"info","ts":"2026-09-11T18:10:18.496754Z","caller":"traceutil/trace.go:171","msg":"trace[86095694] transaction","detail":"{read_only:false; response_revision:14697; number_of_response:1; }","duration":"112.50628ms","start":"2026-09-11T18:10:18.38419Z","end":"2026-09-11T18:10:18.496697Z","steps":["trace[86095694] 'process raft request'  (duration: 76.957853ms)","trace[86095694] 'compare'  (duration: 35.426925ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:10:56.761918Z","caller":"traceutil/trace.go:171","msg":"trace[1847808093] linearizableReadLoop","detail":"{readStateIndex:15428; appliedIndex:15427; }","duration":"208.317561ms","start":"2026-09-11T18:10:56.553576Z","end":"2026-09-11T18:10:56.761894Z","steps":["trace[1847808093] 'read index received'  (duration: 207.989543ms)","trace[1847808093] 'applied index is now lower than readState.Index'  (duration: 327.058µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:10:56.761988Z","caller":"traceutil/trace.go:171","msg":"trace[792970277] transaction","detail":"{read_only:false; response_revision:14913; number_of_response:1; }","duration":"223.236002ms","start":"2026-09-11T18:10:56.538713Z","end":"2026-09-11T18:10:56.761949Z","steps":["trace[792970277] 'process raft request'  (duration: 222.961835ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:10:56.762192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.590077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-11T18:10:56.762239Z","caller":"traceutil/trace.go:171","msg":"trace[156827827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14913; }","duration":"208.674899ms","start":"2026-09-11T18:10:56.553554Z","end":"2026-09-11T18:10:56.762228Z","steps":["trace[156827827] 'agreement among raft nodes before linearized reading'  (duration: 208.513975ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:10:56.762465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.380798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-11T18:10:56.762551Z","caller":"traceutil/trace.go:171","msg":"trace[2079276468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14913; }","duration":"206.537781ms","start":"2026-09-11T18:10:56.555993Z","end":"2026-09-11T18:10:56.76253Z","steps":["trace[2079276468] 'agreement among raft nodes before linearized reading'  (duration: 206.215744ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:10:56.901344Z","caller":"traceutil/trace.go:171","msg":"trace[2102131453] transaction","detail":"{read_only:false; response_revision:14914; number_of_response:1; }","duration":"135.635072ms","start":"2026-09-11T18:10:56.765686Z","end":"2026-09-11T18:10:56.901321Z","steps":["trace[2102131453] 'process raft request'  (duration: 128.632127ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:10:56.910633Z","caller":"traceutil/trace.go:171","msg":"trace[1761503484] transaction","detail":"{read_only:false; response_revision:14915; number_of_response:1; }","duration":"143.739912ms","start":"2026-09-11T18:10:56.766872Z","end":"2026-09-11T18:10:56.910612Z","steps":["trace[1761503484] 'process raft request'  (duration: 143.588939ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:10:56.910974Z","caller":"traceutil/trace.go:171","msg":"trace[1042622261] transaction","detail":"{read_only:false; response_revision:14916; number_of_response:1; }","duration":"135.053249ms","start":"2026-09-11T18:10:56.775901Z","end":"2026-09-11T18:10:56.910954Z","steps":["trace[1042622261] 'process raft request'  (duration: 134.65813ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:11:07.307097Z","caller":"traceutil/trace.go:171","msg":"trace[1724234096] linearizableReadLoop","detail":"{readStateIndex:15608; appliedIndex:15606; }","duration":"132.021832ms","start":"2026-09-11T18:11:07.175055Z","end":"2026-09-11T18:11:07.307077Z","steps":["trace[1724234096] 'read index received'  (duration: 131.765137ms)","trace[1724234096] 'applied index is now lower than readState.Index'  (duration: 255.875µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:11:07.307254Z","caller":"traceutil/trace.go:171","msg":"trace[238663152] transaction","detail":"{read_only:false; response_revision:15089; number_of_response:1; }","duration":"321.792083ms","start":"2026-09-11T18:11:06.985416Z","end":"2026-09-11T18:11:07.307208Z","steps":["trace[238663152] 'process raft request'  (duration: 321.608189ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:11:07.307117Z","caller":"traceutil/trace.go:171","msg":"trace[590667252] transaction","detail":"{read_only:false; response_revision:15088; number_of_response:1; }","duration":"327.184922ms","start":"2026-09-11T18:11:06.979911Z","end":"2026-09-11T18:11:07.307096Z","steps":["trace[590667252] 'process raft request'  (duration: 326.967977ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:11:07.307422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:11:06.97988Z","time spent":"327.478848ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:14972 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-11T18:11:07.307499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:11:06.9854Z","time spent":"321.961836ms","remote":"127.0.0.1:39520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3708,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17d0d03c-06ef-462e-8656-763044e63dea\" mod_revision:15062 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17d0d03c-06ef-462e-8656-763044e63dea\" value_size:3608 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17d0d03c-06ef-462e-8656-763044e63dea\" > >"}
{"level":"warn","ts":"2026-09-11T18:11:07.3073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.238337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-45kjb\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-09-11T18:11:07.307654Z","caller":"traceutil/trace.go:171","msg":"trace[1177215491] range","detail":"{range_begin:/registry/pods/openstack/keepalived-45kjb; range_end:; response_count:1; response_revision:15089; }","duration":"132.669256ms","start":"2026-09-11T18:11:07.174971Z","end":"2026-09-11T18:11:07.30764Z","steps":["trace[1177215491] 'agreement among raft nodes before linearized reading'  (duration: 132.221457ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:12:44.571542Z","caller":"traceutil/trace.go:171","msg":"trace[822026392] transaction","detail":"{read_only:false; response_revision:16160; number_of_response:1; }","duration":"259.427332ms","start":"2026-09-11T18:12:44.312087Z","end":"2026-09-11T18:12:44.571514Z","steps":["trace[822026392] 'process raft request'  (duration: 259.266548ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:12:44.571657Z","caller":"traceutil/trace.go:171","msg":"trace[1174471395] linearizableReadLoop","detail":"{readStateIndex:16712; appliedIndex:16712; }","duration":"143.878794ms","start":"2026-09-11T18:12:44.42774Z","end":"2026-09-11T18:12:44.571619Z","steps":["trace[1174471395] 'read index received'  (duration: 143.864574ms)","trace[1174471395] 'applied index is now lower than readState.Index'  (duration: 11.69µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:12:44.571843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.098578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-09-11T18:12:44.571908Z","caller":"traceutil/trace.go:171","msg":"trace[1826376160] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16160; }","duration":"144.197861ms","start":"2026-09-11T18:12:44.427678Z","end":"2026-09-11T18:12:44.571876Z","steps":["trace[1826376160] 'agreement among raft nodes before linearized reading'  (duration: 144.053778ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:12:44.571974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.897001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-7vslq\" ","response":"range_response_count:1 size:9798"}
{"level":"info","ts":"2026-09-11T18:12:44.572037Z","caller":"traceutil/trace.go:171","msg":"trace[1493510260] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-7vslq; range_end:; response_count:1; response_revision:16160; }","duration":"133.011254ms","start":"2026-09-11T18:12:44.43901Z","end":"2026-09-11T18:12:44.572022Z","steps":["trace[1493510260] 'agreement among raft nodes before linearized reading'  (duration: 132.804799ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:15:17.649658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14691}
{"level":"info","ts":"2026-09-11T18:15:17.730973Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14691,"took":"78.484097ms","hash":1616743726,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":32550912,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-09-11T18:15:17.731038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1616743726,"revision":14691,"compact-revision":12653}
{"level":"info","ts":"2026-09-11T18:18:26.514302Z","caller":"traceutil/trace.go:171","msg":"trace[436663397] transaction","detail":"{read_only:false; response_revision:18661; number_of_response:1; }","duration":"124.601645ms","start":"2026-09-11T18:18:26.389669Z","end":"2026-09-11T18:18:26.514271Z","steps":["trace[436663397] 'process raft request'  (duration: 124.413121ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:18:31.464275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.526864ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299207463 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:18683 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-11T18:18:31.464394Z","caller":"traceutil/trace.go:171","msg":"trace[773743492] transaction","detail":"{read_only:false; response_revision:18695; number_of_response:1; }","duration":"184.526131ms","start":"2026-09-11T18:18:31.279845Z","end":"2026-09-11T18:18:31.464371Z","steps":["trace[773743492] 'process raft request'  (duration: 65.766302ms)","trace[773743492] 'compare'  (duration: 118.399172ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:18:31.482983Z","caller":"traceutil/trace.go:171","msg":"trace[150474087] transaction","detail":"{read_only:false; response_revision:18696; number_of_response:1; }","duration":"203.041571ms","start":"2026-09-11T18:18:31.27991Z","end":"2026-09-11T18:18:31.482952Z","steps":["trace[150474087] 'process raft request'  (duration: 202.651012ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:19:23.511171Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"328ca0518abde8c2","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-11T18:19:23.516634Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-11T18:19:23.516733Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-11T18:20:17.657009Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17255}
{"level":"info","ts":"2026-09-11T18:20:17.758535Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17255,"took":"98.359847ms","hash":1295145468,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":34033664,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-11T18:20:17.758606Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1295145468,"revision":17255,"compact-revision":14691}
{"level":"warn","ts":"2026-09-11T18:24:15.469993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.385604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-11T18:24:15.470094Z","caller":"traceutil/trace.go:171","msg":"trace[1317105268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21387; }","duration":"108.531978ms","start":"2026-09-11T18:24:15.361543Z","end":"2026-09-11T18:24:15.470075Z","steps":["trace[1317105268] 'range keys from in-memory index tree'  (duration: 108.213171ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:24:31.464234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.254636ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299215403 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:68c2a0918e4c4c2a>","response":"size:40"}
{"level":"info","ts":"2026-09-11T18:24:31.464489Z","caller":"traceutil/trace.go:171","msg":"trace[680400133] transaction","detail":"{read_only:false; response_revision:21472; number_of_response:1; }","duration":"166.057731ms","start":"2026-09-11T18:24:31.298413Z","end":"2026-09-11T18:24:31.464471Z","steps":["trace[680400133] 'process raft request'  (duration: 165.917438ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:24:31.75671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.285305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-11T18:24:31.756795Z","caller":"traceutil/trace.go:171","msg":"trace[285461838] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21473; }","duration":"189.446838ms","start":"2026-09-11T18:24:31.567329Z","end":"2026-09-11T18:24:31.756776Z","steps":["trace[285461838] 'range keys from in-memory index tree'  (duration: 188.856495ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:24:31.756806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.339977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-11T18:24:31.756883Z","caller":"traceutil/trace.go:171","msg":"trace[437350901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21473; }","duration":"129.461829ms","start":"2026-09-11T18:24:31.627401Z","end":"2026-09-11T18:24:31.756862Z","steps":["trace[437350901] 'range keys from in-memory index tree'  (duration: 129.089551ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:24:32.548879Z","caller":"traceutil/trace.go:171","msg":"trace[506891952] transaction","detail":"{read_only:false; response_revision:21476; number_of_response:1; }","duration":"105.935521ms","start":"2026-09-11T18:24:32.442889Z","end":"2026-09-11T18:24:32.548825Z","steps":["trace[506891952] 'process raft request'  (duration: 105.755576ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:24:32.718254Z","caller":"traceutil/trace.go:171","msg":"trace[432456497] transaction","detail":"{read_only:false; response_revision:21477; number_of_response:1; }","duration":"137.832501ms","start":"2026-09-11T18:24:32.580388Z","end":"2026-09-11T18:24:32.718221Z","steps":["trace[432456497] 'process raft request'  (duration: 137.395992ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:25:17.664222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19780}
{"level":"info","ts":"2026-09-11T18:25:17.780017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19780,"took":"113.149448ms","hash":2310822099,"current-db-size-bytes":55668736,"current-db-size":"56 MB","current-db-size-in-use-bytes":30351360,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-11T18:25:17.780064Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2310822099,"revision":19780,"compact-revision":17255}
2026/09/11 18:29:21 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-09-11T18:30:17.671692Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21999}
{"level":"info","ts":"2026-09-11T18:30:17.783532Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21999,"took":"107.755338ms","hash":4176882796,"current-db-size-bytes":56631296,"current-db-size":"57 MB","current-db-size-in-use-bytes":43937792,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-09-11T18:30:17.783905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4176882796,"revision":21999,"compact-revision":19780}
{"level":"info","ts":"2026-09-11T18:32:07.039338Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006916.wal"}
{"level":"warn","ts":"2026-09-11T18:32:19.085072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.871855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-11T18:32:19.085192Z","caller":"traceutil/trace.go:171","msg":"trace[394215616] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:26201; }","duration":"186.021048ms","start":"2026-09-11T18:32:18.89913Z","end":"2026-09-11T18:32:19.085151Z","steps":["trace[394215616] 'count revisions from in-memory index tree'  (duration: 185.780393ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:19.085386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.518506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:19.085461Z","caller":"traceutil/trace.go:171","msg":"trace[107084000] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:26201; }","duration":"128.654859ms","start":"2026-09-11T18:32:18.956788Z","end":"2026-09-11T18:32:19.085443Z","steps":["trace[107084000] 'count revisions from in-memory index tree'  (duration: 128.428974ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:19.085431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.107066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:19.085578Z","caller":"traceutil/trace.go:171","msg":"trace[1977838459] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26201; }","duration":"184.27405ms","start":"2026-09-11T18:32:18.901258Z","end":"2026-09-11T18:32:19.085532Z","steps":["trace[1977838459] 'count revisions from in-memory index tree'  (duration: 184.047595ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:19.156862Z","caller":"traceutil/trace.go:171","msg":"trace[214142657] linearizableReadLoop","detail":"{readStateIndex:27067; appliedIndex:27066; }","duration":"124.0508ms","start":"2026-09-11T18:32:19.032786Z","end":"2026-09-11T18:32:19.156837Z","steps":["trace[214142657] 'read index received'  (duration: 123.944288ms)","trace[214142657] 'applied index is now lower than readState.Index'  (duration: 105.122µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:19.157078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.269615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-09-11T18:32:19.157117Z","caller":"traceutil/trace.go:171","msg":"trace[1644605532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26202; }","duration":"124.354677ms","start":"2026-09-11T18:32:19.032753Z","end":"2026-09-11T18:32:19.157107Z","steps":["trace[1644605532] 'agreement among raft nodes before linearized reading'  (duration: 124.180043ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:19.157473Z","caller":"traceutil/trace.go:171","msg":"trace[147391930] transaction","detail":"{read_only:false; response_revision:26202; number_of_response:1; }","duration":"126.909602ms","start":"2026-09-11T18:32:19.030553Z","end":"2026-09-11T18:32:19.157462Z","steps":["trace[147391930] 'process raft request'  (duration: 126.119825ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:19.306601Z","caller":"traceutil/trace.go:171","msg":"trace[549941178] transaction","detail":"{read_only:false; response_revision:26203; number_of_response:1; }","duration":"146.044595ms","start":"2026-09-11T18:32:19.160527Z","end":"2026-09-11T18:32:19.306572Z","steps":["trace[549941178] 'process raft request'  (duration: 145.83562ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:19.636128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.505145ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299227991 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26185 > 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-09-11T18:32:19.636272Z","caller":"traceutil/trace.go:171","msg":"trace[1646941159] linearizableReadLoop","detail":"{readStateIndex:27070; appliedIndex:27069; }","duration":"231.325728ms","start":"2026-09-11T18:32:19.404919Z","end":"2026-09-11T18:32:19.636244Z","steps":["trace[1646941159] 'read index received'  (duration: 65.582357ms)","trace[1646941159] 'applied index is now lower than readState.Index'  (duration: 165.741851ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:19.63633Z","caller":"traceutil/trace.go:171","msg":"trace[626262224] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"292.555121ms","start":"2026-09-11T18:32:19.34373Z","end":"2026-09-11T18:32:19.636285Z","steps":["trace[626262224] 'process raft request'  (duration: 126.80391ms)","trace[626262224] 'compare'  (duration: 165.301441ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:19.636468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.532142ms","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-09-11T18:32:19.636513Z","caller":"traceutil/trace.go:171","msg":"trace[263452255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26205; }","duration":"231.635444ms","start":"2026-09-11T18:32:19.404864Z","end":"2026-09-11T18:32:19.636499Z","steps":["trace[263452255] 'agreement among raft nodes before linearized reading'  (duration: 231.469471ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:23.427233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.670249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-09-11T18:32:23.427321Z","caller":"traceutil/trace.go:171","msg":"trace[1985215120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26237; }","duration":"103.804712ms","start":"2026-09-11T18:32:23.323496Z","end":"2026-09-11T18:32:23.427301Z","steps":["trace[1985215120] 'range keys from in-memory index tree'  (duration: 103.455965ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:23.761959Z","caller":"traceutil/trace.go:171","msg":"trace[84901835] linearizableReadLoop","detail":"{readStateIndex:27105; appliedIndex:27104; }","duration":"112.277796ms","start":"2026-09-11T18:32:23.649656Z","end":"2026-09-11T18:32:23.761933Z","steps":["trace[84901835] 'read index received'  (duration: 104.61833ms)","trace[84901835] 'applied index is now lower than readState.Index'  (duration: 7.658416ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:23.761996Z","caller":"traceutil/trace.go:171","msg":"trace[1403435473] transaction","detail":"{read_only:false; response_revision:26239; number_of_response:1; }","duration":"330.389498ms","start":"2026-09-11T18:32:23.431573Z","end":"2026-09-11T18:32:23.761962Z","steps":["trace[1403435473] 'process raft request'  (duration: 322.766193ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:23.762275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.600263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-11T18:32:23.762554Z","caller":"traceutil/trace.go:171","msg":"trace[1661062519] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26239; }","duration":"112.93436ms","start":"2026-09-11T18:32:23.649595Z","end":"2026-09-11T18:32:23.762529Z","steps":["trace[1661062519] 'agreement among raft nodes before linearized reading'  (duration: 112.46979ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:23.762494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:23.43154Z","time spent":"330.854897ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26224 > 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-09-11T18:32:24.028396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.440393ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228076 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26227 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-11T18:32:24.028623Z","caller":"traceutil/trace.go:171","msg":"trace[897914410] transaction","detail":"{read_only:false; response_revision:26242; number_of_response:1; }","duration":"141.825874ms","start":"2026-09-11T18:32:23.88678Z","end":"2026-09-11T18:32:24.028606Z","steps":["trace[897914410] 'process raft request'  (duration: 141.782123ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:24.028832Z","caller":"traceutil/trace.go:171","msg":"trace[1575776003] transaction","detail":"{read_only:false; response_revision:26241; number_of_response:1; }","duration":"261.253184ms","start":"2026-09-11T18:32:23.767546Z","end":"2026-09-11T18:32:24.028799Z","steps":["trace[1575776003] 'process raft request'  (duration: 260.943337ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:24.029039Z","caller":"traceutil/trace.go:171","msg":"trace[348349186] transaction","detail":"{read_only:false; response_revision:26240; number_of_response:1; }","duration":"262.675034ms","start":"2026-09-11T18:32:23.766292Z","end":"2026-09-11T18:32:24.028967Z","steps":["trace[348349186] 'process raft request'  (duration: 134.580947ms)","trace[348349186] 'compare'  (duration: 127.328691ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:24.461132Z","caller":"traceutil/trace.go:171","msg":"trace[659874757] linearizableReadLoop","detail":"{readStateIndex:27110; appliedIndex:27109; }","duration":"141.825383ms","start":"2026-09-11T18:32:24.319113Z","end":"2026-09-11T18:32:24.460939Z","steps":["trace[659874757] 'read index received'  (duration: 141.504066ms)","trace[659874757] 'applied index is now lower than readState.Index'  (duration: 320.077µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:24.461266Z","caller":"traceutil/trace.go:171","msg":"trace[1149497738] transaction","detail":"{read_only:false; response_revision:26244; number_of_response:1; }","duration":"230.836667ms","start":"2026-09-11T18:32:24.230401Z","end":"2026-09-11T18:32:24.461237Z","steps":["trace[1149497738] 'process raft request'  (duration: 230.293015ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:24.461404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.274693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-11T18:32:24.461447Z","caller":"traceutil/trace.go:171","msg":"trace[599894559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26244; }","duration":"142.337104ms","start":"2026-09-11T18:32:24.319099Z","end":"2026-09-11T18:32:24.461436Z","steps":["trace[599894559] 'agreement among raft nodes before linearized reading'  (duration: 142.17373ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:25.083448Z","caller":"traceutil/trace.go:171","msg":"trace[2007936901] transaction","detail":"{read_only:false; response_revision:26250; number_of_response:1; }","duration":"255.902447ms","start":"2026-09-11T18:32:24.827516Z","end":"2026-09-11T18:32:25.083418Z","steps":["trace[2007936901] 'process raft request'  (duration: 255.629772ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:25.2824Z","caller":"traceutil/trace.go:171","msg":"trace[623850590] transaction","detail":"{read_only:false; response_revision:26251; number_of_response:1; }","duration":"115.068496ms","start":"2026-09-11T18:32:25.167291Z","end":"2026-09-11T18:32:25.282359Z","steps":["trace[623850590] 'process raft request'  (duration: 99.867018ms)","trace[623850590] 'compare'  (duration: 14.885832ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:25.287432Z","caller":"traceutil/trace.go:171","msg":"trace[1071221697] transaction","detail":"{read_only:false; response_revision:26252; number_of_response:1; }","duration":"108.983474ms","start":"2026-09-11T18:32:25.178425Z","end":"2026-09-11T18:32:25.287409Z","steps":["trace[1071221697] 'process raft request'  (duration: 108.883462ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:25.53811Z","caller":"traceutil/trace.go:171","msg":"trace[608627107] transaction","detail":"{read_only:false; response_revision:26253; number_of_response:1; }","duration":"104.445277ms","start":"2026-09-11T18:32:25.433621Z","end":"2026-09-11T18:32:25.538066Z","steps":["trace[608627107] 'process raft request'  (duration: 100.829488ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:25.822447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.314609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:25.822573Z","caller":"traceutil/trace.go:171","msg":"trace[1394950295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26253; }","duration":"145.465033ms","start":"2026-09-11T18:32:25.67706Z","end":"2026-09-11T18:32:25.822525Z","steps":["trace[1394950295] 'range keys from in-memory index tree'  (duration: 145.227958ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:26.260898Z","caller":"traceutil/trace.go:171","msg":"trace[1058675533] linearizableReadLoop","detail":"{readStateIndex:27121; appliedIndex:27120; }","duration":"227.182578ms","start":"2026-09-11T18:32:26.033689Z","end":"2026-09-11T18:32:26.260872Z","steps":["trace[1058675533] 'read index received'  (duration: 227.024304ms)","trace[1058675533] 'applied index is now lower than readState.Index'  (duration: 156.754µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:26.260969Z","caller":"traceutil/trace.go:171","msg":"trace[234054532] transaction","detail":"{read_only:false; response_revision:26255; number_of_response:1; }","duration":"227.816652ms","start":"2026-09-11T18:32:26.033121Z","end":"2026-09-11T18:32:26.260938Z","steps":["trace[234054532] 'process raft request'  (duration: 227.593637ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.261123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.402672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-11T18:32:26.26116Z","caller":"traceutil/trace.go:171","msg":"trace[812926016] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26255; }","duration":"227.484544ms","start":"2026-09-11T18:32:26.033665Z","end":"2026-09-11T18:32:26.26115Z","steps":["trace[812926016] 'agreement among raft nodes before linearized reading'  (duration: 227.31947ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.492495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.50924ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228103 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26240 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-11T18:32:26.492605Z","caller":"traceutil/trace.go:171","msg":"trace[986783644] linearizableReadLoop","detail":"{readStateIndex:27122; appliedIndex:27121; }","duration":"231.623473ms","start":"2026-09-11T18:32:26.260963Z","end":"2026-09-11T18:32:26.492586Z","steps":["trace[986783644] 'read index received'  (duration: 119.050061ms)","trace[986783644] 'applied index is now lower than readState.Index'  (duration: 112.572262ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:26.492818Z","caller":"traceutil/trace.go:171","msg":"trace[1007268561] transaction","detail":"{read_only:false; response_revision:26256; number_of_response:1; }","duration":"427.067395ms","start":"2026-09-11T18:32:26.065737Z","end":"2026-09-11T18:32:26.492804Z","steps":["trace[1007268561] 'process raft request'  (duration: 314.178607ms)","trace[1007268561] 'compare'  (duration: 112.400708ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:26.492885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.065704Z","time spent":"427.147177ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26240 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-09-11T18:32:26.493071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.565564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:26.493115Z","caller":"traceutil/trace.go:171","msg":"trace[1759714004] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:26256; }","duration":"325.648256ms","start":"2026-09-11T18:32:26.167453Z","end":"2026-09-11T18:32:26.493102Z","steps":["trace[1759714004] 'agreement among raft nodes before linearized reading'  (duration: 325.578254ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.493141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.167431Z","time spent":"325.703236ms","remote":"127.0.0.1:53098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":28,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "}
{"level":"info","ts":"2026-09-11T18:32:26.523822Z","caller":"traceutil/trace.go:171","msg":"trace[925712420] transaction","detail":"{read_only:false; response_revision:26257; number_of_response:1; }","duration":"257.738078ms","start":"2026-09-11T18:32:26.266055Z","end":"2026-09-11T18:32:26.523793Z","steps":["trace[925712420] 'process raft request'  (duration: 257.245726ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.798838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.38019ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228106 > lease_revoke:<id:68c2a0918e4c7cc1>","response":"size:28"}
{"level":"info","ts":"2026-09-11T18:32:26.800015Z","caller":"traceutil/trace.go:171","msg":"trace[147251228] transaction","detail":"{read_only:false; response_revision:26258; number_of_response:1; }","duration":"333.097616ms","start":"2026-09-11T18:32:26.466899Z","end":"2026-09-11T18:32:26.799996Z","steps":["trace[147251228] 'process raft request'  (duration: 332.039984ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.800131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.466872Z","time spent":"333.187728ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26244 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-09-11T18:32:26.812502Z","caller":"traceutil/trace.go:171","msg":"trace[1739104561] linearizableReadLoop","detail":"{readStateIndex:27126; appliedIndex:27122; }","duration":"319.852251ms","start":"2026-09-11T18:32:26.492627Z","end":"2026-09-11T18:32:26.812479Z","steps":["trace[1739104561] 'read index received'  (duration: 30.595401ms)","trace[1739104561] 'applied index is now lower than readState.Index'  (duration: 289.25545ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:26.812691Z","caller":"traceutil/trace.go:171","msg":"trace[1867027837] transaction","detail":"{read_only:false; response_revision:26259; number_of_response:1; }","duration":"335.721673ms","start":"2026-09-11T18:32:26.476956Z","end":"2026-09-11T18:32:26.812677Z","steps":["trace[1867027837] 'process raft request'  (duration: 323.029378ms)","trace[1867027837] 'compare'  (duration: 12.136712ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:26.812793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.476926Z","time spent":"335.795625ms","remote":"127.0.0.1:39586","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:26245 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-11T18:32:26.813044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.618779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-11T18:32:26.813075Z","caller":"traceutil/trace.go:171","msg":"trace[681696361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26259; }","duration":"322.687681ms","start":"2026-09-11T18:32:26.490378Z","end":"2026-09-11T18:32:26.813065Z","steps":["trace[681696361] 'agreement among raft nodes before linearized reading'  (duration: 322.577449ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.813101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.490356Z","time spent":"322.738473ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-11T18:32:26.81325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.864065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-11T18:32:26.813274Z","caller":"traceutil/trace.go:171","msg":"trace[528638335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26259; }","duration":"322.927106ms","start":"2026-09-11T18:32:26.490339Z","end":"2026-09-11T18:32:26.813266Z","steps":["trace[528638335] 'agreement among raft nodes before linearized reading'  (duration: 322.853955ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.813297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.490309Z","time spent":"322.982018ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-11T18:32:26.813376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.615471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:26.813405Z","caller":"traceutil/trace.go:171","msg":"trace[927321027] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:26259; }","duration":"529.681463ms","start":"2026-09-11T18:32:26.283715Z","end":"2026-09-11T18:32:26.813397Z","steps":["trace[927321027] 'agreement among raft nodes before linearized reading'  (duration: 529.636582ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.813428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.283695Z","time spent":"529.726804ms","remote":"127.0.0.1:60774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-09-11T18:32:26.861431Z","caller":"traceutil/trace.go:171","msg":"trace[85199575] transaction","detail":"{read_only:false; response_revision:26260; number_of_response:1; }","duration":"219.805238ms","start":"2026-09-11T18:32:26.641603Z","end":"2026-09-11T18:32:26.861408Z","steps":["trace[85199575] 'process raft request'  (duration: 219.679515ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:26.97321Z","caller":"traceutil/trace.go:171","msg":"trace[992509844] linearizableReadLoop","detail":"{readStateIndex:27128; appliedIndex:27126; }","duration":"160.600649ms","start":"2026-09-11T18:32:26.812558Z","end":"2026-09-11T18:32:26.973158Z","steps":["trace[992509844] 'read index received'  (duration: 48.753023ms)","trace[992509844] 'applied index is now lower than readState.Index'  (duration: 111.846026ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:26.973382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.817088ms","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-09-11T18:32:26.973426Z","caller":"traceutil/trace.go:171","msg":"trace[1195555171] 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:26263; }","duration":"412.91421ms","start":"2026-09-11T18:32:26.5605Z","end":"2026-09-11T18:32:26.973414Z","steps":["trace[1195555171] 'agreement among raft nodes before linearized reading'  (duration: 412.794527ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:26.973465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:26.560476Z","time spent":"412.979282ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"info","ts":"2026-09-11T18:32:26.973877Z","caller":"traceutil/trace.go:171","msg":"trace[1727332821] transaction","detail":"{read_only:false; response_revision:26261; number_of_response:1; }","duration":"280.036819ms","start":"2026-09-11T18:32:26.693825Z","end":"2026-09-11T18:32:26.973862Z","steps":["trace[1727332821] 'process raft request'  (duration: 266.20297ms)","trace[1727332821] 'compare'  (duration: 12.650344ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:26.974037Z","caller":"traceutil/trace.go:171","msg":"trace[1623772046] transaction","detail":"{read_only:false; response_revision:26262; number_of_response:1; }","duration":"156.657735ms","start":"2026-09-11T18:32:26.81737Z","end":"2026-09-11T18:32:26.974028Z","steps":["trace[1623772046] 'process raft request'  (duration: 155.638583ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:26.974226Z","caller":"traceutil/trace.go:171","msg":"trace[1059099237] transaction","detail":"{read_only:false; response_revision:26263; number_of_response:1; }","duration":"152.139987ms","start":"2026-09-11T18:32:26.822067Z","end":"2026-09-11T18:32:26.974207Z","steps":["trace[1059099237] 'process raft request'  (duration: 151.031713ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:27.262109Z","caller":"traceutil/trace.go:171","msg":"trace[2875963] transaction","detail":"{read_only:false; response_revision:26264; number_of_response:1; }","duration":"173.07957ms","start":"2026-09-11T18:32:27.088998Z","end":"2026-09-11T18:32:27.262077Z","steps":["trace[2875963] 'process raft request'  (duration: 153.371434ms)","trace[2875963] 'compare'  (duration: 19.083773ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:27.552866Z","caller":"traceutil/trace.go:171","msg":"trace[987190426] linearizableReadLoop","detail":"{readStateIndex:27132; appliedIndex:27131; }","duration":"210.456636ms","start":"2026-09-11T18:32:27.342379Z","end":"2026-09-11T18:32:27.552836Z","steps":["trace[987190426] 'read index received'  (duration: 202.825471ms)","trace[987190426] 'applied index is now lower than readState.Index'  (duration: 7.629795ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:27.552979Z","caller":"traceutil/trace.go:171","msg":"trace[2123004072] transaction","detail":"{read_only:false; response_revision:26265; number_of_response:1; }","duration":"259.314893ms","start":"2026-09-11T18:32:27.293651Z","end":"2026-09-11T18:32:27.552966Z","steps":["trace[2123004072] 'process raft request'  (duration: 251.498264ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:27.553222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.657291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"}
{"level":"info","ts":"2026-09-11T18:32:27.553304Z","caller":"traceutil/trace.go:171","msg":"trace[1321184256] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:26265; }","duration":"210.919297ms","start":"2026-09-11T18:32:27.342363Z","end":"2026-09-11T18:32:27.553282Z","steps":["trace[1321184256] 'agreement among raft nodes before linearized reading'  (duration: 210.60124ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:27.643026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.529734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:27.643103Z","caller":"traceutil/trace.go:171","msg":"trace[1307064102] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:26267; }","duration":"226.664667ms","start":"2026-09-11T18:32:27.416421Z","end":"2026-09-11T18:32:27.643086Z","steps":["trace[1307064102] 'agreement among raft nodes before linearized reading'  (duration: 226.523584ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:27.643175Z","caller":"traceutil/trace.go:171","msg":"trace[652012513] transaction","detail":"{read_only:false; response_revision:26266; number_of_response:1; }","duration":"270.270268ms","start":"2026-09-11T18:32:27.372877Z","end":"2026-09-11T18:32:27.643147Z","steps":["trace[652012513] 'process raft request'  (duration: 269.875409ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:27.643267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.000728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:27.643324Z","caller":"traceutil/trace.go:171","msg":"trace[853529225] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:26267; }","duration":"292.069709ms","start":"2026-09-11T18:32:27.35124Z","end":"2026-09-11T18:32:27.64331Z","steps":["trace[853529225] 'agreement among raft nodes before linearized reading'  (duration: 291.968077ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:39.820093Z","caller":"traceutil/trace.go:171","msg":"trace[187440045] transaction","detail":"{read_only:false; response_revision:26413; number_of_response:1; }","duration":"137.452549ms","start":"2026-09-11T18:32:39.682609Z","end":"2026-09-11T18:32:39.820061Z","steps":["trace[187440045] 'process raft request'  (duration: 45.292708ms)","trace[187440045] 'compare'  (duration: 92.027898ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:40.376323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.570364ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228493 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:26283 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-11T18:32:40.376428Z","caller":"traceutil/trace.go:171","msg":"trace[542072542] transaction","detail":"{read_only:false; response_revision:26415; number_of_response:1; }","duration":"295.82182ms","start":"2026-09-11T18:32:40.080586Z","end":"2026-09-11T18:32:40.376408Z","steps":["trace[542072542] 'process raft request'  (duration: 150.083382ms)","trace[542072542] 'compare'  (duration: 145.026153ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:40.532574Z","caller":"traceutil/trace.go:171","msg":"trace[470037858] transaction","detail":"{read_only:false; response_revision:26416; number_of_response:1; }","duration":"210.505037ms","start":"2026-09-11T18:32:40.322029Z","end":"2026-09-11T18:32:40.532534Z","steps":["trace[470037858] 'process raft request'  (duration: 197.045616ms)","trace[470037858] 'compare'  (duration: 12.998781ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:40.828993Z","caller":"traceutil/trace.go:171","msg":"trace[1473584810] linearizableReadLoop","detail":"{readStateIndex:27286; appliedIndex:27285; }","duration":"276.239478ms","start":"2026-09-11T18:32:40.552714Z","end":"2026-09-11T18:32:40.828954Z","steps":["trace[1473584810] 'read index received'  (duration: 255.895959ms)","trace[1473584810] 'applied index is now lower than readState.Index'  (duration: 20.341639ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:40.829204Z","caller":"traceutil/trace.go:171","msg":"trace[1232790499] transaction","detail":"{read_only:false; response_revision:26417; number_of_response:1; }","duration":"287.271105ms","start":"2026-09-11T18:32:40.541856Z","end":"2026-09-11T18:32:40.829128Z","steps":["trace[1232790499] 'process raft request'  (duration: 266.731632ms)","trace[1232790499] 'compare'  (duration: 19.692756ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:40.829613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.056798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:40.82969Z","caller":"traceutil/trace.go:171","msg":"trace[1346328269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26417; }","duration":"154.16467ms","start":"2026-09-11T18:32:40.675508Z","end":"2026-09-11T18:32:40.829673Z","steps":["trace[1346328269] 'agreement among raft nodes before linearized reading'  (duration: 154.044387ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:40.829696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.884916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-09-11T18:32:40.829704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.890218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-09-11T18:32:40.829777Z","caller":"traceutil/trace.go:171","msg":"trace[1429513612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26417; }","duration":"230.012859ms","start":"2026-09-11T18:32:40.599742Z","end":"2026-09-11T18:32:40.829755Z","steps":["trace[1429513612] 'agreement among raft nodes before linearized reading'  (duration: 229.793274ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:40.829791Z","caller":"traceutil/trace.go:171","msg":"trace[1802940055] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181; range_end:; response_count:1; response_revision:26417; }","duration":"169.033451ms","start":"2026-09-11T18:32:40.660734Z","end":"2026-09-11T18:32:40.829768Z","steps":["trace[1802940055] 'agreement among raft nodes before linearized reading'  (duration: 168.836677ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:40.830361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.648928ms","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-09-11T18:32:40.83104Z","caller":"traceutil/trace.go:171","msg":"trace[1528178366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26417; }","duration":"278.366354ms","start":"2026-09-11T18:32:40.552654Z","end":"2026-09-11T18:32:40.83102Z","steps":["trace[1528178366] 'agreement among raft nodes before linearized reading'  (duration: 276.472482ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:40.98026Z","caller":"traceutil/trace.go:171","msg":"trace[814141974] transaction","detail":"{read_only:false; response_revision:26419; number_of_response:1; }","duration":"144.375149ms","start":"2026-09-11T18:32:40.835859Z","end":"2026-09-11T18:32:40.980234Z","steps":["trace[814141974] 'process raft request'  (duration: 142.855716ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:40.980275Z","caller":"traceutil/trace.go:171","msg":"trace[980525707] transaction","detail":"{read_only:false; response_revision:26421; number_of_response:1; }","duration":"117.158182ms","start":"2026-09-11T18:32:40.863101Z","end":"2026-09-11T18:32:40.980259Z","steps":["trace[980525707] 'process raft request'  (duration: 117.06234ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:40.980262Z","caller":"traceutil/trace.go:171","msg":"trace[1905894374] transaction","detail":"{read_only:false; response_revision:26420; number_of_response:1; }","duration":"139.408952ms","start":"2026-09-11T18:32:40.840827Z","end":"2026-09-11T18:32:40.980236Z","steps":["trace[1905894374] 'process raft request'  (duration: 139.29794ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:41.393636Z","caller":"traceutil/trace.go:171","msg":"trace[47023937] linearizableReadLoop","detail":"{readStateIndex:27292; appliedIndex:27291; }","duration":"330.451539ms","start":"2026-09-11T18:32:41.063152Z","end":"2026-09-11T18:32:41.393604Z","steps":["trace[47023937] 'read index received'  (duration: 330.305456ms)","trace[47023937] 'applied index is now lower than readState.Index'  (duration: 144.723µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:41.39377Z","caller":"traceutil/trace.go:171","msg":"trace[2056751732] transaction","detail":"{read_only:false; response_revision:26423; number_of_response:1; }","duration":"352.846593ms","start":"2026-09-11T18:32:41.040912Z","end":"2026-09-11T18:32:41.393758Z","steps":["trace[2056751732] 'process raft request'  (duration: 352.488575ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:41.393914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:41.040888Z","time spent":"352.941065ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26402 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-11T18:32:41.394191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.00038ms","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-09-11T18:32:41.39427Z","caller":"traceutil/trace.go:171","msg":"trace[2033899780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26423; }","duration":"331.142533ms","start":"2026-09-11T18:32:41.063108Z","end":"2026-09-11T18:32:41.39425Z","steps":["trace[2033899780] 'agreement among raft nodes before linearized reading'  (duration: 330.925189ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:41.394308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:41.063089Z","time spent":"331.210514ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-11T18:32:41.412623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.141652ms","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-09-11T18:32:41.4127Z","caller":"traceutil/trace.go:171","msg":"trace[1703595950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26424; }","duration":"349.246524ms","start":"2026-09-11T18:32:41.063435Z","end":"2026-09-11T18:32:41.412682Z","steps":["trace[1703595950] 'agreement among raft nodes before linearized reading'  (duration: 349.025459ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:41.412745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:41.063427Z","time spent":"349.308795ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-11T18:32:41.412734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.499624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.28\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-09-11T18:32:41.41281Z","caller":"traceutil/trace.go:171","msg":"trace[195950157] range","detail":"{range_begin:/registry/masterleases/162.253.55.28; range_end:; response_count:1; response_revision:26424; }","duration":"177.643977ms","start":"2026-09-11T18:32:41.235148Z","end":"2026-09-11T18:32:41.412792Z","steps":["trace[195950157] 'agreement among raft nodes before linearized reading'  (duration: 177.397352ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:41.687995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.917794ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228508 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26404 > 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-09-11T18:32:41.688305Z","caller":"traceutil/trace.go:171","msg":"trace[1658846293] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"253.284343ms","start":"2026-09-11T18:32:41.435002Z","end":"2026-09-11T18:32:41.688286Z","steps":["trace[1658846293] 'process raft request'  (duration: 253.211401ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:41.688347Z","caller":"traceutil/trace.go:171","msg":"trace[1732327153] transaction","detail":"{read_only:false; response_revision:26425; number_of_response:1; }","duration":"290.25272ms","start":"2026-09-11T18:32:41.398071Z","end":"2026-09-11T18:32:41.688324Z","steps":["trace[1732327153] 'process raft request'  (duration: 161.935498ms)","trace[1732327153] 'compare'  (duration: 127.807012ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:41.717833Z","caller":"traceutil/trace.go:171","msg":"trace[1823967476] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"111.794615ms","start":"2026-09-11T18:32:41.605778Z","end":"2026-09-11T18:32:41.717573Z","steps":["trace[1823967476] 'process raft request'  (duration: 111.6033ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:42.111448Z","caller":"traceutil/trace.go:171","msg":"trace[416598245] linearizableReadLoop","detail":"{readStateIndex:27299; appliedIndex:27298; }","duration":"275.356459ms","start":"2026-09-11T18:32:41.836068Z","end":"2026-09-11T18:32:42.111425Z","steps":["trace[416598245] 'read index received'  (duration: 275.186535ms)","trace[416598245] 'applied index is now lower than readState.Index'  (duration: 168.934µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:42.111503Z","caller":"traceutil/trace.go:171","msg":"trace[1415348891] transaction","detail":"{read_only:false; response_revision:26429; number_of_response:1; }","duration":"286.104991ms","start":"2026-09-11T18:32:41.825366Z","end":"2026-09-11T18:32:42.111471Z","steps":["trace[1415348891] 'process raft request'  (duration: 285.891676ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:42.111681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.593983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181\" ","response":"range_response_count:1 size:3763"}
{"level":"info","ts":"2026-09-11T18:32:42.111715Z","caller":"traceutil/trace.go:171","msg":"trace[1394557948] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181; range_end:; response_count:1; response_revision:26429; }","duration":"275.691695ms","start":"2026-09-11T18:32:41.836012Z","end":"2026-09-11T18:32:42.111704Z","steps":["trace[1394557948] 'agreement among raft nodes before linearized reading'  (duration: 275.536532ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:42.111728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.641788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-11T18:32:42.111802Z","caller":"traceutil/trace.go:171","msg":"trace[349462927] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:26429; }","duration":"183.77561ms","start":"2026-09-11T18:32:41.928006Z","end":"2026-09-11T18:32:42.111781Z","steps":["trace[349462927] 'agreement among raft nodes before linearized reading'  (duration: 183.599786ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:42.900565Z","caller":"traceutil/trace.go:171","msg":"trace[2130484372] linearizableReadLoop","detail":"{readStateIndex:27303; appliedIndex:27302; }","duration":"224.756106ms","start":"2026-09-11T18:32:42.675786Z","end":"2026-09-11T18:32:42.900542Z","steps":["trace[2130484372] 'read index received'  (duration: 224.569811ms)","trace[2130484372] 'applied index is now lower than readState.Index'  (duration: 185.115µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:42.900687Z","caller":"traceutil/trace.go:171","msg":"trace[2111560657] transaction","detail":"{read_only:false; response_revision:26433; number_of_response:1; }","duration":"230.129062ms","start":"2026-09-11T18:32:42.670495Z","end":"2026-09-11T18:32:42.900624Z","steps":["trace[2111560657] 'process raft request'  (duration: 229.921176ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:42.900759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.982411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:42.901002Z","caller":"traceutil/trace.go:171","msg":"trace[158764564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26433; }","duration":"225.242806ms","start":"2026-09-11T18:32:42.675715Z","end":"2026-09-11T18:32:42.900957Z","steps":["trace[158764564] 'agreement among raft nodes before linearized reading'  (duration: 224.911389ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.495553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.922988ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228531 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26418 > 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-09-11T18:32:43.495836Z","caller":"traceutil/trace.go:171","msg":"trace[605975284] transaction","detail":"{read_only:false; response_revision:26437; number_of_response:1; }","duration":"508.185809ms","start":"2026-09-11T18:32:42.987631Z","end":"2026-09-11T18:32:43.495817Z","steps":["trace[605975284] 'process raft request'  (duration: 508.146258ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.495911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:42.987622Z","time spent":"508.25432ms","remote":"127.0.0.1:39586","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:26421 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-11T18:32:43.496103Z","caller":"traceutil/trace.go:171","msg":"trace[1788068380] transaction","detail":"{read_only:false; response_revision:26435; number_of_response:1; }","duration":"510.261903ms","start":"2026-09-11T18:32:42.985829Z","end":"2026-09-11T18:32:43.496091Z","steps":["trace[1788068380] 'process raft request'  (duration: 509.850465ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.496164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:42.985792Z","time spent":"510.342115ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26422 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-11T18:32:43.49629Z","caller":"traceutil/trace.go:171","msg":"trace[454363275] linearizableReadLoop","detail":"{readStateIndex:27304; appliedIndex:27303; }","duration":"511.142391ms","start":"2026-09-11T18:32:42.985135Z","end":"2026-09-11T18:32:43.496278Z","steps":["trace[454363275] 'read index received'  (duration: 229.562339ms)","trace[454363275] 'applied index is now lower than readState.Index'  (duration: 281.578612ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:43.496302Z","caller":"traceutil/trace.go:171","msg":"trace[1955696515] transaction","detail":"{read_only:false; response_revision:26436; number_of_response:1; }","duration":"509.524647ms","start":"2026-09-11T18:32:42.986745Z","end":"2026-09-11T18:32:43.49627Z","steps":["trace[1955696515] 'process raft request'  (duration: 508.999106ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:43.496376Z","caller":"traceutil/trace.go:171","msg":"trace[26124837] transaction","detail":"{read_only:false; response_revision:26434; number_of_response:1; }","duration":"559.853875ms","start":"2026-09-11T18:32:42.936507Z","end":"2026-09-11T18:32:43.496361Z","steps":["trace[26124837] 'process raft request'  (duration: 278.040608ms)","trace[26124837] 'compare'  (duration: 280.268964ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:32:43.496438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:42.936482Z","time spent":"559.925546ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26418 > 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-09-11T18:32:43.496467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:42.986707Z","time spent":"509.678011ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26420 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-09-11T18:32:43.496625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.462909ms","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-09-11T18:32:43.496725Z","caller":"traceutil/trace.go:171","msg":"trace[1868437294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26437; }","duration":"511.612592ms","start":"2026-09-11T18:32:42.985087Z","end":"2026-09-11T18:32:43.496699Z","steps":["trace[1868437294] 'agreement among raft nodes before linearized reading'  (duration: 511.291586ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.496778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:42.985064Z","time spent":"511.701944ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-11T18:32:43.501057Z","caller":"traceutil/trace.go:171","msg":"trace[952412782] transaction","detail":"{read_only:false; response_revision:26438; number_of_response:1; }","duration":"101.405861ms","start":"2026-09-11T18:32:43.399626Z","end":"2026-09-11T18:32:43.501032Z","steps":["trace[952412782] 'process raft request'  (duration: 100.959661ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.501387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.937233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-11T18:32:43.501508Z","caller":"traceutil/trace.go:171","msg":"trace[1749082924] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26439; }","duration":"364.059935ms","start":"2026-09-11T18:32:43.137428Z","end":"2026-09-11T18:32:43.501488Z","steps":["trace[1749082924] 'agreement among raft nodes before linearized reading'  (duration: 363.80856ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.501595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:43.137367Z","time spent":"364.211678ms","remote":"127.0.0.1:39520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-11T18:32:43.501848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.653525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-11T18:32:43.501904Z","caller":"traceutil/trace.go:171","msg":"trace[43162521] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:26439; }","duration":"219.745767ms","start":"2026-09-11T18:32:43.282145Z","end":"2026-09-11T18:32:43.50189Z","steps":["trace[43162521] 'agreement among raft nodes before linearized reading'  (duration: 219.643355ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.501427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.495106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181\" ","response":"range_response_count:1 size:3763"}
{"level":"warn","ts":"2026-09-11T18:32:43.502009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.021858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:32:43.502097Z","caller":"traceutil/trace.go:171","msg":"trace[1349801288] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:26439; }","duration":"136.162731ms","start":"2026-09-11T18:32:43.365914Z","end":"2026-09-11T18:32:43.502077Z","steps":["trace[1349801288] 'agreement among raft nodes before linearized reading'  (duration: 136.018168ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:43.502042Z","caller":"traceutil/trace.go:171","msg":"trace[857376824] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181; range_end:; response_count:1; response_revision:26439; }","duration":"385.16781ms","start":"2026-09-11T18:32:43.11685Z","end":"2026-09-11T18:32:43.502018Z","steps":["trace[857376824] 'agreement among raft nodes before linearized reading'  (duration: 384.458465ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:43.502281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:32:43.116821Z","time spent":"385.433875ms","remote":"127.0.0.1:39520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3785,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-34499230-8a9e-4206-9473-4e82c1881181\" "}
{"level":"info","ts":"2026-09-11T18:32:49.663133Z","caller":"traceutil/trace.go:171","msg":"trace[1093361468] transaction","detail":"{read_only:false; response_revision:26499; number_of_response:1; }","duration":"139.30889ms","start":"2026-09-11T18:32:49.523799Z","end":"2026-09-11T18:32:49.663107Z","steps":["trace[1093361468] 'process raft request'  (duration: 139.144935ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:49.797656Z","caller":"traceutil/trace.go:171","msg":"trace[1354231180] linearizableReadLoop","detail":"{readStateIndex:27375; appliedIndex:27370; }","duration":"259.268881ms","start":"2026-09-11T18:32:49.538368Z","end":"2026-09-11T18:32:49.797637Z","steps":["trace[1354231180] 'read index received'  (duration: 124.652032ms)","trace[1354231180] 'applied index is now lower than readState.Index'  (duration: 134.616079ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:32:49.797747Z","caller":"traceutil/trace.go:171","msg":"trace[470597425] transaction","detail":"{read_only:false; response_revision:26502; number_of_response:1; }","duration":"263.553323ms","start":"2026-09-11T18:32:49.534187Z","end":"2026-09-11T18:32:49.79774Z","steps":["trace[470597425] 'process raft request'  (duration: 263.39898ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:49.797842Z","caller":"traceutil/trace.go:171","msg":"trace[560975340] transaction","detail":"{read_only:false; response_revision:26501; number_of_response:1; }","duration":"264.28827ms","start":"2026-09-11T18:32:49.533478Z","end":"2026-09-11T18:32:49.797766Z","steps":["trace[560975340] 'process raft request'  (duration: 264.077495ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:49.798046Z","caller":"traceutil/trace.go:171","msg":"trace[1673182307] transaction","detail":"{read_only:false; response_revision:26503; number_of_response:1; }","duration":"263.518312ms","start":"2026-09-11T18:32:49.534507Z","end":"2026-09-11T18:32:49.798025Z","steps":["trace[1673182307] 'process raft request'  (duration: 263.103574ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:32:49.798046Z","caller":"traceutil/trace.go:171","msg":"trace[742667031] transaction","detail":"{read_only:false; response_revision:26500; number_of_response:1; }","duration":"266.755863ms","start":"2026-09-11T18:32:49.531274Z","end":"2026-09-11T18:32:49.798029Z","steps":["trace[742667031] 'process raft request'  (duration: 266.15088ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:49.798222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.831174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-11T18:32:49.798293Z","caller":"traceutil/trace.go:171","msg":"trace[113138041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26503; }","duration":"259.957707ms","start":"2026-09-11T18:32:49.538314Z","end":"2026-09-11T18:32:49.798272Z","steps":["trace[113138041] 'agreement among raft nodes before linearized reading'  (duration: 259.725272ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:32:49.798404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.944006ms","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-09-11T18:32:49.798434Z","caller":"traceutil/trace.go:171","msg":"trace[2033931128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26504; }","duration":"260.003877ms","start":"2026-09-11T18:32:49.538422Z","end":"2026-09-11T18:32:49.798426Z","steps":["trace[2033931128] 'agreement among raft nodes before linearized reading'  (duration: 259.874894ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:01.47587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.220436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228908 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.28\" mod_revision:26519 > success:<request_put:<key:\"/registry/masterleases/162.253.55.28\" value_size:67 lease:7548772472444453098 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.28\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-11T18:33:01.475968Z","caller":"traceutil/trace.go:171","msg":"trace[1302258447] linearizableReadLoop","detail":"{readStateIndex:27470; appliedIndex:27469; }","duration":"142.222642ms","start":"2026-09-11T18:33:01.333729Z","end":"2026-09-11T18:33:01.475952Z","steps":["trace[1302258447] 'read index received'  (duration: 34.908994ms)","trace[1302258447] 'applied index is now lower than readState.Index'  (duration: 107.311738ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:01.476083Z","caller":"traceutil/trace.go:171","msg":"trace[2128474954] transaction","detail":"{read_only:false; response_revision:26595; number_of_response:1; }","duration":"151.496452ms","start":"2026-09-11T18:33:01.324574Z","end":"2026-09-11T18:33:01.476071Z","steps":["trace[2128474954] 'process raft request'  (duration: 44.023031ms)","trace[2128474954] 'compare'  (duration: 106.654674ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:33:01.476491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.753324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-09-11T18:33:01.477693Z","caller":"traceutil/trace.go:171","msg":"trace[472217394] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:26595; }","duration":"143.973279ms","start":"2026-09-11T18:33:01.333696Z","end":"2026-09-11T18:33:01.477669Z","steps":["trace[472217394] 'agreement among raft nodes before linearized reading'  (duration: 142.64641ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:01.818787Z","caller":"traceutil/trace.go:171","msg":"trace[571310268] transaction","detail":"{read_only:false; response_revision:26596; number_of_response:1; }","duration":"114.922932ms","start":"2026-09-11T18:33:01.703847Z","end":"2026-09-11T18:33:01.81877Z","steps":["trace[571310268] 'process raft request'  (duration: 114.81206ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.095927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.952492ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299228917 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:26550 > 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-09-11T18:33:02.096059Z","caller":"traceutil/trace.go:171","msg":"trace[1010845165] linearizableReadLoop","detail":"{readStateIndex:27472; appliedIndex:27470; }","duration":"376.822511ms","start":"2026-09-11T18:33:01.719214Z","end":"2026-09-11T18:33:02.096036Z","steps":["trace[1010845165] 'read index received'  (duration: 99.525671ms)","trace[1010845165] 'applied index is now lower than readState.Index'  (duration: 277.29464ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:02.096167Z","caller":"traceutil/trace.go:171","msg":"trace[221702827] transaction","detail":"{read_only:false; response_revision:26597; number_of_response:1; }","duration":"387.936161ms","start":"2026-09-11T18:33:01.708197Z","end":"2026-09-11T18:33:02.096134Z","steps":["trace[221702827] 'process raft request'  (duration: 241.669162ms)","trace[221702827] 'compare'  (duration: 145.82402ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:33:02.09623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.998865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:33:02.096281Z","caller":"traceutil/trace.go:171","msg":"trace[1572958883] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:26597; }","duration":"377.054916ms","start":"2026-09-11T18:33:01.719208Z","end":"2026-09-11T18:33:02.096263Z","steps":["trace[1572958883] 'agreement among raft nodes before linearized reading'  (duration: 376.939323ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.096327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.719136Z","time spent":"377.175878ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true "}
{"level":"warn","ts":"2026-09-11T18:33:02.096354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.708149Z","time spent":"388.111985ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:26550 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-09-11T18:33:02.16657Z","caller":"traceutil/trace.go:171","msg":"trace[78733291] transaction","detail":"{read_only:false; response_revision:26598; number_of_response:1; }","duration":"325.335898ms","start":"2026-09-11T18:33:01.841206Z","end":"2026-09-11T18:33:02.166542Z","steps":["trace[78733291] 'process raft request'  (duration: 325.054912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.166832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.841164Z","time spent":"325.536723ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26584 > 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-09-11T18:33:02.167001Z","caller":"traceutil/trace.go:171","msg":"trace[788472280] transaction","detail":"{read_only:false; response_revision:26599; number_of_response:1; }","duration":"324.9608ms","start":"2026-09-11T18:33:01.842008Z","end":"2026-09-11T18:33:02.166969Z","steps":["trace[788472280] 'process raft request'  (duration: 324.373288ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.1672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.841988Z","time spent":"325.095723ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26583 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-11T18:33:02.167575Z","caller":"traceutil/trace.go:171","msg":"trace[1440148316] transaction","detail":"{read_only:false; response_revision:26600; number_of_response:1; }","duration":"325.202686ms","start":"2026-09-11T18:33:01.842347Z","end":"2026-09-11T18:33:02.16755Z","steps":["trace[1440148316] 'process raft request'  (duration: 324.498231ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.167721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.84233Z","time spent":"325.319528ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26582 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-09-11T18:33:02.168061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.884323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-11T18:33:02.168131Z","caller":"traceutil/trace.go:171","msg":"trace[259187137] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26602; }","duration":"302.970375ms","start":"2026-09-11T18:33:01.865142Z","end":"2026-09-11T18:33:02.168112Z","steps":["trace[259187137] 'agreement among raft nodes before linearized reading'  (duration: 302.7445ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:02.168203Z","caller":"traceutil/trace.go:171","msg":"trace[333238419] transaction","detail":"{read_only:false; response_revision:26602; number_of_response:1; }","duration":"323.720033ms","start":"2026-09-11T18:33:01.844442Z","end":"2026-09-11T18:33:02.168162Z","steps":["trace[333238419] 'process raft request'  (duration: 323.347115ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.168269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.844432Z","time spent":"323.807994ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26586 > 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-09-11T18:33:02.168316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.457204ms","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-09-11T18:33:02.168365Z","caller":"traceutil/trace.go:171","msg":"trace[308922986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26602; }","duration":"296.536387ms","start":"2026-09-11T18:33:01.871817Z","end":"2026-09-11T18:33:02.168353Z","steps":["trace[308922986] 'agreement among raft nodes before linearized reading'  (duration: 296.418693ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.168441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.262768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-11T18:33:02.168205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.865135Z","time spent":"303.031887ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-11T18:33:02.168565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.205891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-11T18:33:02.168595Z","caller":"traceutil/trace.go:171","msg":"trace[1406323330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26602; }","duration":"297.275543ms","start":"2026-09-11T18:33:01.871312Z","end":"2026-09-11T18:33:02.168587Z","steps":["trace[1406323330] 'agreement among raft nodes before linearized reading'  (duration: 297.195981ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.168131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.103356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-11T18:33:02.168715Z","caller":"traceutil/trace.go:171","msg":"trace[1892432147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26602; }","duration":"296.74477ms","start":"2026-09-11T18:33:01.871963Z","end":"2026-09-11T18:33:02.168708Z","steps":["trace[1892432147] 'agreement among raft nodes before linearized reading'  (duration: 296.065825ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:02.168481Z","caller":"traceutil/trace.go:171","msg":"trace[61892328] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:26602; }","duration":"276.32721ms","start":"2026-09-11T18:33:01.892142Z","end":"2026-09-11T18:33:02.168469Z","steps":["trace[61892328] 'agreement among raft nodes before linearized reading'  (duration: 276.258779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:02.168755Z","caller":"traceutil/trace.go:171","msg":"trace[629721229] transaction","detail":"{read_only:false; response_revision:26601; number_of_response:1; }","duration":"326.147507ms","start":"2026-09-11T18:33:01.84258Z","end":"2026-09-11T18:33:02.168727Z","steps":["trace[629721229] 'process raft request'  (duration: 324.882599ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:02.168863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:33:01.842572Z","time spent":"326.235088ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26585 > 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":"info","ts":"2026-09-11T18:33:02.318048Z","caller":"traceutil/trace.go:171","msg":"trace[662273313] transaction","detail":"{read_only:false; response_revision:26604; number_of_response:1; }","duration":"144.785808ms","start":"2026-09-11T18:33:02.173237Z","end":"2026-09-11T18:33:02.318023Z","steps":["trace[662273313] 'process raft request'  (duration: 144.519522ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:02.31843Z","caller":"traceutil/trace.go:171","msg":"trace[660245961] transaction","detail":"{read_only:false; response_revision:26605; number_of_response:1; }","duration":"144.097552ms","start":"2026-09-11T18:33:02.17432Z","end":"2026-09-11T18:33:02.318418Z","steps":["trace[660245961] 'process raft request'  (duration: 143.633492ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:02.318609Z","caller":"traceutil/trace.go:171","msg":"trace[519966146] transaction","detail":"{read_only:false; response_revision:26606; number_of_response:1; }","duration":"142.778824ms","start":"2026-09-11T18:33:02.175799Z","end":"2026-09-11T18:33:02.318577Z","steps":["trace[519966146] 'process raft request'  (duration: 142.484928ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:02.318776Z","caller":"traceutil/trace.go:171","msg":"trace[1771993898] transaction","detail":"{read_only:false; response_revision:26607; number_of_response:1; }","duration":"139.686448ms","start":"2026-09-11T18:33:02.17906Z","end":"2026-09-11T18:33:02.318746Z","steps":["trace[1771993898] 'process raft request'  (duration: 139.354901ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:10.337059Z","caller":"traceutil/trace.go:171","msg":"trace[674747994] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"138.770748ms","start":"2026-09-11T18:33:10.198261Z","end":"2026-09-11T18:33:10.337032Z","steps":["trace[674747994] 'process raft request'  (duration: 138.560123ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:10.33753Z","caller":"traceutil/trace.go:171","msg":"trace[745531427] transaction","detail":"{read_only:false; response_revision:26672; number_of_response:1; }","duration":"138.645026ms","start":"2026-09-11T18:33:10.198855Z","end":"2026-09-11T18:33:10.3375Z","steps":["trace[745531427] 'process raft request'  (duration: 138.134904ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:10.33767Z","caller":"traceutil/trace.go:171","msg":"trace[2095829986] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"135.592309ms","start":"2026-09-11T18:33:10.202047Z","end":"2026-09-11T18:33:10.337639Z","steps":["trace[2095829986] 'process raft request'  (duration: 135.222182ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:10.337727Z","caller":"traceutil/trace.go:171","msg":"trace[1535335613] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"135.194771ms","start":"2026-09-11T18:33:10.202517Z","end":"2026-09-11T18:33:10.337712Z","steps":["trace[1535335613] 'process raft request'  (duration: 134.853244ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:17.339524Z","caller":"traceutil/trace.go:171","msg":"trace[1937892256] linearizableReadLoop","detail":"{readStateIndex:27604; appliedIndex:27603; }","duration":"218.569691ms","start":"2026-09-11T18:33:17.120936Z","end":"2026-09-11T18:33:17.339506Z","steps":["trace[1937892256] 'read index received'  (duration: 213.91567ms)","trace[1937892256] 'applied index is now lower than readState.Index'  (duration: 4.653461ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:17.33961Z","caller":"traceutil/trace.go:171","msg":"trace[579202956] transaction","detail":"{read_only:false; response_revision:26725; number_of_response:1; }","duration":"230.232033ms","start":"2026-09-11T18:33:17.109371Z","end":"2026-09-11T18:33:17.339603Z","steps":["trace[579202956] 'process raft request'  (duration: 225.542872ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:17.339713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.758255ms","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-09-11T18:33:17.339737Z","caller":"traceutil/trace.go:171","msg":"trace[1854996014] 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:26725; }","duration":"218.830757ms","start":"2026-09-11T18:33:17.1209Z","end":"2026-09-11T18:33:17.33973Z","steps":["trace[1854996014] 'agreement among raft nodes before linearized reading'  (duration: 218.773096ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:17.339868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.524151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:33:17.339888Z","caller":"traceutil/trace.go:171","msg":"trace[1324627278] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:26725; }","duration":"106.582282ms","start":"2026-09-11T18:33:17.233301Z","end":"2026-09-11T18:33:17.339884Z","steps":["trace[1324627278] 'agreement among raft nodes before linearized reading'  (duration: 106.517201ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.414035Z","caller":"traceutil/trace.go:171","msg":"trace[9510479] transaction","detail":"{read_only:false; response_revision:26742; number_of_response:1; }","duration":"144.796347ms","start":"2026-09-11T18:33:20.269212Z","end":"2026-09-11T18:33:20.414008Z","steps":["trace[9510479] 'process raft request'  (duration: 144.638396ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.640455Z","caller":"traceutil/trace.go:171","msg":"trace[711009919] transaction","detail":"{read_only:false; response_revision:26743; number_of_response:1; }","duration":"266.660501ms","start":"2026-09-11T18:33:20.373753Z","end":"2026-09-11T18:33:20.640414Z","steps":["trace[711009919] 'process raft request'  (duration: 248.299597ms)","trace[711009919] 'compare'  (duration: 17.65199ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:20.64069Z","caller":"traceutil/trace.go:171","msg":"trace[1014944010] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"266.698162ms","start":"2026-09-11T18:33:20.373966Z","end":"2026-09-11T18:33:20.640664Z","steps":["trace[1014944010] 'process raft request'  (duration: 266.220129ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.641089Z","caller":"traceutil/trace.go:171","msg":"trace[900077144] transaction","detail":"{read_only:false; response_revision:26745; number_of_response:1; }","duration":"264.266758ms","start":"2026-09-11T18:33:20.376802Z","end":"2026-09-11T18:33:20.641069Z","steps":["trace[900077144] 'process raft request'  (duration: 263.469003ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.641176Z","caller":"traceutil/trace.go:171","msg":"trace[2097763492] transaction","detail":"{read_only:false; response_revision:26746; number_of_response:1; }","duration":"258.461935ms","start":"2026-09-11T18:33:20.382695Z","end":"2026-09-11T18:33:20.641157Z","steps":["trace[2097763492] 'process raft request'  (duration: 258.280954ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.641199Z","caller":"traceutil/trace.go:171","msg":"trace[1595412415] linearizableReadLoop","detail":"{readStateIndex:27623; appliedIndex:27620; }","duration":"266.318869ms","start":"2026-09-11T18:33:20.374855Z","end":"2026-09-11T18:33:20.641174Z","steps":["trace[1595412415] 'read index received'  (duration: 38.910332ms)","trace[1595412415] 'applied index is now lower than readState.Index'  (duration: 227.407027ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:20.641339Z","caller":"traceutil/trace.go:171","msg":"trace[1820726089] transaction","detail":"{read_only:false; response_revision:26747; number_of_response:1; }","duration":"237.828607ms","start":"2026-09-11T18:33:20.403494Z","end":"2026-09-11T18:33:20.641323Z","steps":["trace[1820726089] 'process raft request'  (duration: 237.577615ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.641462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.59356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-9695c95bd-cfh52.18d456380a1aeae9\" ","response":"range_response_count:1 size:2095"}
{"level":"info","ts":"2026-09-11T18:33:20.641527Z","caller":"traceutil/trace.go:171","msg":"trace[164962766] range","detail":"{range_begin:/registry/events/openstack/glance-api-9695c95bd-cfh52.18d456380a1aeae9; range_end:; response_count:1; response_revision:26747; }","duration":"266.687771ms","start":"2026-09-11T18:33:20.374817Z","end":"2026-09-11T18:33:20.641505Z","steps":["trace[164962766] 'agreement among raft nodes before linearized reading'  (duration: 266.50236ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.641557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.190503ms","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-09-11T18:33:20.641605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.64929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-11T18:33:20.641639Z","caller":"traceutil/trace.go:171","msg":"trace[954338874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26747; }","duration":"237.315123ms","start":"2026-09-11T18:33:20.40431Z","end":"2026-09-11T18:33:20.641625Z","steps":["trace[954338874] 'agreement among raft nodes before linearized reading'  (duration: 237.062982ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.64167Z","caller":"traceutil/trace.go:171","msg":"trace[1035319848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26747; }","duration":"208.760471ms","start":"2026-09-11T18:33:20.43289Z","end":"2026-09-11T18:33:20.64165Z","steps":["trace[1035319848] 'agreement among raft nodes before linearized reading'  (duration: 208.611501ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.641877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.389696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-09-11T18:33:20.641917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.78914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-11T18:33:20.641993Z","caller":"traceutil/trace.go:171","msg":"trace[1445287816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26747; }","duration":"206.87906ms","start":"2026-09-11T18:33:20.4351Z","end":"2026-09-11T18:33:20.641979Z","steps":["trace[1445287816] 'agreement among raft nodes before linearized reading'  (duration: 206.685929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.641959Z","caller":"traceutil/trace.go:171","msg":"trace[1634833438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26747; }","duration":"211.494956ms","start":"2026-09-11T18:33:20.430453Z","end":"2026-09-11T18:33:20.641948Z","steps":["trace[1634833438] 'agreement among raft nodes before linearized reading'  (duration: 211.311805ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.64215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.07166ms","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-09-11T18:33:20.64219Z","caller":"traceutil/trace.go:171","msg":"trace[730933334] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:26747; }","duration":"212.14524ms","start":"2026-09-11T18:33:20.430031Z","end":"2026-09-11T18:33:20.642176Z","steps":["trace[730933334] 'agreement among raft nodes before linearized reading'  (duration: 212.03019ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.642186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.962126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-09-11T18:33:20.642237Z","caller":"traceutil/trace.go:171","msg":"trace[2134569605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26747; }","duration":"231.042967ms","start":"2026-09-11T18:33:20.411178Z","end":"2026-09-11T18:33:20.642221Z","steps":["trace[2134569605] 'agreement among raft nodes before linearized reading'  (duration: 230.888657ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.812053Z","caller":"traceutil/trace.go:171","msg":"trace[1810390000] transaction","detail":"{read_only:false; response_revision:26751; number_of_response:1; }","duration":"165.633655ms","start":"2026-09-11T18:33:20.646396Z","end":"2026-09-11T18:33:20.81203Z","steps":["trace[1810390000] 'process raft request'  (duration: 165.560184ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.81208Z","caller":"traceutil/trace.go:171","msg":"trace[890841897] transaction","detail":"{read_only:false; response_revision:26749; number_of_response:1; }","duration":"165.930988ms","start":"2026-09-11T18:33:20.64611Z","end":"2026-09-11T18:33:20.812041Z","steps":["trace[890841897] 'process raft request'  (duration: 165.660046ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.812152Z","caller":"traceutil/trace.go:171","msg":"trace[1643889230] transaction","detail":"{read_only:false; response_revision:26750; number_of_response:1; }","duration":"165.771126ms","start":"2026-09-11T18:33:20.646323Z","end":"2026-09-11T18:33:20.812094Z","steps":["trace[1643889230] 'process raft request'  (duration: 165.595745ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.812323Z","caller":"traceutil/trace.go:171","msg":"trace[808299982] transaction","detail":"{read_only:false; response_revision:26752; number_of_response:1; }","duration":"165.353663ms","start":"2026-09-11T18:33:20.646954Z","end":"2026-09-11T18:33:20.812308Z","steps":["trace[808299982] 'process raft request'  (duration: 165.037941ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.812545Z","caller":"traceutil/trace.go:171","msg":"trace[761029356] linearizableReadLoop","detail":"{readStateIndex:27629; appliedIndex:27626; }","duration":"166.161857ms","start":"2026-09-11T18:33:20.646366Z","end":"2026-09-11T18:33:20.812528Z","steps":["trace[761029356] 'read index received'  (duration: 74.781666ms)","trace[761029356] 'applied index is now lower than readState.Index'  (duration: 91.379151ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:20.812662Z","caller":"traceutil/trace.go:171","msg":"trace[2134173924] transaction","detail":"{read_only:false; response_revision:26753; number_of_response:1; }","duration":"164.556749ms","start":"2026-09-11T18:33:20.648092Z","end":"2026-09-11T18:33:20.812649Z","steps":["trace[2134173924] 'process raft request'  (duration: 164.166137ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.812817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.791091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:33:20.812839Z","caller":"traceutil/trace.go:171","msg":"trace[2059013653] transaction","detail":"{read_only:false; response_revision:26754; number_of_response:1; }","duration":"164.229297ms","start":"2026-09-11T18:33:20.648589Z","end":"2026-09-11T18:33:20.812818Z","steps":["trace[2059013653] 'process raft request'  (duration: 163.835875ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.812871Z","caller":"traceutil/trace.go:171","msg":"trace[909575448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26754; }","duration":"136.867081ms","start":"2026-09-11T18:33:20.675988Z","end":"2026-09-11T18:33:20.812855Z","steps":["trace[909575448] 'agreement among raft nodes before linearized reading'  (duration: 136.789881ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:20.814147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.407548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:33:20.814219Z","caller":"traceutil/trace.go:171","msg":"trace[236611405] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:26754; }","duration":"167.870257ms","start":"2026-09-11T18:33:20.64633Z","end":"2026-09-11T18:33:20.8142Z","steps":["trace[236611405] 'agreement among raft nodes before linearized reading'  (duration: 166.383779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:20.988862Z","caller":"traceutil/trace.go:171","msg":"trace[893841980] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"150.567559ms","start":"2026-09-11T18:33:20.838267Z","end":"2026-09-11T18:33:20.988835Z","steps":["trace[893841980] 'process raft request'  (duration: 115.205297ms)","trace[893841980] 'compare'  (duration: 34.740089ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:33:34.795367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.333428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-11T18:33:34.795389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.289544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:33:34.795459Z","caller":"traceutil/trace.go:171","msg":"trace[1932341554] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:26846; }","duration":"115.466609ms","start":"2026-09-11T18:33:34.679974Z","end":"2026-09-11T18:33:34.79544Z","steps":["trace[1932341554] 'count revisions from in-memory index tree'  (duration: 115.266557ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:34.795506Z","caller":"traceutil/trace.go:171","msg":"trace[1238654905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26846; }","duration":"118.468105ms","start":"2026-09-11T18:33:34.67701Z","end":"2026-09-11T18:33:34.795478Z","steps":["trace[1238654905] 'range keys from in-memory index tree'  (duration: 118.203694ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:34.805441Z","caller":"traceutil/trace.go:171","msg":"trace[73894284] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"102.405854ms","start":"2026-09-11T18:33:34.703013Z","end":"2026-09-11T18:33:34.805419Z","steps":["trace[73894284] 'process raft request'  (duration: 102.242663ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:34.80564Z","caller":"traceutil/trace.go:171","msg":"trace[74995970] transaction","detail":"{read_only:false; response_revision:26849; number_of_response:1; }","duration":"101.084706ms","start":"2026-09-11T18:33:34.704535Z","end":"2026-09-11T18:33:34.80562Z","steps":["trace[74995970] 'process raft request'  (duration: 100.835865ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:34.874242Z","caller":"traceutil/trace.go:171","msg":"trace[1145275594] transaction","detail":"{read_only:false; response_revision:26851; number_of_response:1; }","duration":"148.575278ms","start":"2026-09-11T18:33:34.725614Z","end":"2026-09-11T18:33:34.87419Z","steps":["trace[1145275594] 'process raft request'  (duration: 148.490728ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:34.874256Z","caller":"traceutil/trace.go:171","msg":"trace[1521348163] transaction","detail":"{read_only:false; response_revision:26850; number_of_response:1; }","duration":"149.003211ms","start":"2026-09-11T18:33:34.725225Z","end":"2026-09-11T18:33:34.874228Z","steps":["trace[1521348163] 'process raft request'  (duration: 148.742959ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:35.029994Z","caller":"traceutil/trace.go:171","msg":"trace[262495980] transaction","detail":"{read_only:false; response_revision:26852; number_of_response:1; }","duration":"150.148916ms","start":"2026-09-11T18:33:34.879814Z","end":"2026-09-11T18:33:35.029963Z","steps":["trace[262495980] 'process raft request'  (duration: 69.943519ms)","trace[262495980] 'compare'  (duration: 80.000426ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:33:35.029971Z","caller":"traceutil/trace.go:171","msg":"trace[1766013272] linearizableReadLoop","detail":"{readStateIndex:27734; appliedIndex:27733; }","duration":"148.444957ms","start":"2026-09-11T18:33:34.881496Z","end":"2026-09-11T18:33:35.029941Z","steps":["trace[1766013272] 'read index received'  (duration: 68.25218ms)","trace[1766013272] 'applied index is now lower than readState.Index'  (duration: 80.191557ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:33:35.030173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.655778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-11T18:33:35.030215Z","caller":"traceutil/trace.go:171","msg":"trace[171266032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26852; }","duration":"148.732198ms","start":"2026-09-11T18:33:34.881473Z","end":"2026-09-11T18:33:35.030205Z","steps":["trace[171266032] 'agreement among raft nodes before linearized reading'  (duration: 148.574117ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:35.11235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.325187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:33:35.112451Z","caller":"traceutil/trace.go:171","msg":"trace[1898231666] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:26853; }","duration":"220.488378ms","start":"2026-09-11T18:33:34.891938Z","end":"2026-09-11T18:33:35.112427Z","steps":["trace[1898231666] 'agreement among raft nodes before linearized reading'  (duration: 220.299207ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:35.112455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.177772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-09-11T18:33:35.112484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.124845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"warn","ts":"2026-09-11T18:33:35.112361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.208408ms","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-09-11T18:33:35.112519Z","caller":"traceutil/trace.go:171","msg":"trace[2114903696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26853; }","duration":"228.247913ms","start":"2026-09-11T18:33:34.884248Z","end":"2026-09-11T18:33:35.112496Z","steps":["trace[2114903696] 'agreement among raft nodes before linearized reading'  (duration: 228.153023ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:35.112545Z","caller":"traceutil/trace.go:171","msg":"trace[674026668] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26853; }","duration":"225.209705ms","start":"2026-09-11T18:33:34.887317Z","end":"2026-09-11T18:33:35.112527Z","steps":["trace[674026668] 'agreement among raft nodes before linearized reading'  (duration: 225.011534ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:33:35.112574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.187027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"warn","ts":"2026-09-11T18:33:35.112583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.995207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-11T18:33:35.112596Z","caller":"traceutil/trace.go:171","msg":"trace[241986380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26853; }","duration":"229.454579ms","start":"2026-09-11T18:33:34.883112Z","end":"2026-09-11T18:33:35.112567Z","steps":["trace[241986380] 'agreement among raft nodes before linearized reading'  (duration: 229.103908ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:35.112633Z","caller":"traceutil/trace.go:171","msg":"trace[867089518] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26853; }","duration":"201.273009ms","start":"2026-09-11T18:33:34.911343Z","end":"2026-09-11T18:33:35.112616Z","steps":["trace[867089518] 'agreement among raft nodes before linearized reading'  (duration: 201.107648ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:35.112659Z","caller":"traceutil/trace.go:171","msg":"trace[1169271903] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26853; }","duration":"222.128988ms","start":"2026-09-11T18:33:34.890511Z","end":"2026-09-11T18:33:35.11264Z","steps":["trace[1169271903] 'agreement among raft nodes before linearized reading'  (duration: 221.875417ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:33:55.843261Z","caller":"traceutil/trace.go:171","msg":"trace[1886823052] transaction","detail":"{read_only:false; number_of_response:0; response_revision:27019; }","duration":"114.632364ms","start":"2026-09-11T18:33:55.728602Z","end":"2026-09-11T18:33:55.843234Z","steps":["trace[1886823052] 'process raft request'  (duration: 114.504573ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:34:00.503438Z","caller":"traceutil/trace.go:171","msg":"trace[2084111681] linearizableReadLoop","detail":"{readStateIndex:28077; appliedIndex:28076; }","duration":"230.693847ms","start":"2026-09-11T18:34:00.272716Z","end":"2026-09-11T18:34:00.50341Z","steps":["trace[2084111681] 'read index received'  (duration: 230.483024ms)","trace[2084111681] 'applied index is now lower than readState.Index'  (duration: 209.652µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:34:00.50352Z","caller":"traceutil/trace.go:171","msg":"trace[955798105] transaction","detail":"{read_only:false; response_revision:27189; number_of_response:1; }","duration":"323.418885ms","start":"2026-09-11T18:34:00.180044Z","end":"2026-09-11T18:34:00.503463Z","steps":["trace[955798105] 'process raft request'  (duration: 323.201933ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:34:00.503706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.293765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-11T18:34:00.503757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T18:34:00.180005Z","time spent":"323.616387ms","remote":"127.0.0.1:39586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:27170 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-11T18:34:00.503807Z","caller":"traceutil/trace.go:171","msg":"trace[207288289] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:27189; }","duration":"153.449666ms","start":"2026-09-11T18:34:00.350336Z","end":"2026-09-11T18:34:00.503786Z","steps":["trace[207288289] 'agreement among raft nodes before linearized reading'  (duration: 153.294525ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:34:00.503922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.210479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-09-11T18:34:00.503972Z","caller":"traceutil/trace.go:171","msg":"trace[449544899] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:27189; }","duration":"231.33746ms","start":"2026-09-11T18:34:00.272619Z","end":"2026-09-11T18:34:00.503956Z","steps":["trace[449544899] 'agreement among raft nodes before linearized reading'  (duration: 230.951318ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:34:31.359736Z","caller":"traceutil/trace.go:171","msg":"trace[1839380736] transaction","detail":"{read_only:false; response_revision:27451; number_of_response:1; }","duration":"192.065535ms","start":"2026-09-11T18:34:31.167634Z","end":"2026-09-11T18:34:31.359699Z","steps":["trace[1839380736] 'process raft request'  (duration: 117.921652ms)","trace[1839380736] 'compare'  (duration: 73.955932ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:34:31.360117Z","caller":"traceutil/trace.go:171","msg":"trace[661811302] linearizableReadLoop","detail":"{readStateIndex:28348; appliedIndex:28345; }","duration":"151.231653ms","start":"2026-09-11T18:34:31.208852Z","end":"2026-09-11T18:34:31.360083Z","steps":["trace[661811302] 'read index received'  (duration: 76.718627ms)","trace[661811302] 'applied index is now lower than readState.Index'  (duration: 74.511986ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:34:31.36027Z","caller":"traceutil/trace.go:171","msg":"trace[975369957] transaction","detail":"{read_only:false; response_revision:27453; number_of_response:1; }","duration":"183.202456ms","start":"2026-09-11T18:34:31.177053Z","end":"2026-09-11T18:34:31.360255Z","steps":["trace[975369957] 'process raft request'  (duration: 182.904333ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:34:31.360275Z","caller":"traceutil/trace.go:171","msg":"trace[1717619029] transaction","detail":"{read_only:false; response_revision:27452; number_of_response:1; }","duration":"183.597088ms","start":"2026-09-11T18:34:31.176653Z","end":"2026-09-11T18:34:31.36025Z","steps":["trace[1717619029] 'process raft request'  (duration: 182.987354ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:34:31.360498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.634195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-11T18:34:31.360569Z","caller":"traceutil/trace.go:171","msg":"trace[354717581] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27453; }","duration":"151.758036ms","start":"2026-09-11T18:34:31.208797Z","end":"2026-09-11T18:34:31.360555Z","steps":["trace[354717581] 'agreement among raft nodes before linearized reading'  (duration: 151.484265ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:34:31.388709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.451884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.28\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-09-11T18:34:31.388807Z","caller":"traceutil/trace.go:171","msg":"trace[901466343] range","detail":"{range_begin:/registry/masterleases/162.253.55.28; range_end:; response_count:1; response_revision:27454; }","duration":"144.597825ms","start":"2026-09-11T18:34:31.244183Z","end":"2026-09-11T18:34:31.388781Z","steps":["trace[901466343] 'agreement among raft nodes before linearized reading'  (duration: 144.387604ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:35:17.68148Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25050}
{"level":"info","ts":"2026-09-11T18:35:17.832574Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25050,"took":"146.281484ms","hash":4038738647,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":36536320,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-09-11T18:35:17.832649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4038738647,"revision":25050,"compact-revision":21999}
{"level":"info","ts":"2026-09-11T18:37:20.98459Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"328ca0518abde8c2","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-11T18:37:20.990546Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-11T18:37:20.990651Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-09-11T18:40:17.690269Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27884}
{"level":"info","ts":"2026-09-11T18:40:17.832758Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27884,"took":"138.326288ms","hash":3554076813,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":34496512,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-11T18:40:17.832826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3554076813,"revision":27884,"compact-revision":25050}
{"level":"info","ts":"2026-09-11T18:45:17.696948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30521}
{"level":"info","ts":"2026-09-11T18:45:17.862792Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30521,"took":"161.869411ms","hash":1909201151,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":30846976,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-11T18:45:17.862871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1909201151,"revision":30521,"compact-revision":27884}
{"level":"info","ts":"2026-09-11T18:50:17.708825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32772}
{"level":"info","ts":"2026-09-11T18:50:17.869585Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32772,"took":"156.468316ms","hash":4090845359,"current-db-size-bytes":58515456,"current-db-size":"58 MB","current-db-size-in-use-bytes":30490624,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-11T18:50:17.872747Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4090845359,"revision":32772,"compact-revision":30521}
{"level":"info","ts":"2026-09-11T18:55:17.725578Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35003}
{"level":"info","ts":"2026-09-11T18:55:17.882328Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35003,"took":"151.266434ms","hash":2131701286,"current-db-size-bytes":58515456,"current-db-size":"58 MB","current-db-size-in-use-bytes":31408128,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-11T18:55:17.882398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2131701286,"revision":35003,"compact-revision":32772}
{"level":"info","ts":"2026-09-11T18:55:54.024672Z","caller":"traceutil/trace.go:171","msg":"trace[1951055862] transaction","detail":"{read_only:false; response_revision:37558; number_of_response:1; }","duration":"136.356605ms","start":"2026-09-11T18:55:53.888271Z","end":"2026-09-11T18:55:54.024627Z","steps":["trace[1951055862] 'process raft request'  (duration: 114.685332ms)","trace[1951055862] 'compare'  (duration: 21.178942ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:55:54.199757Z","caller":"traceutil/trace.go:171","msg":"trace[1404743931] transaction","detail":"{read_only:false; response_revision:37559; number_of_response:1; }","duration":"295.732513ms","start":"2026-09-11T18:55:53.903969Z","end":"2026-09-11T18:55:54.199701Z","steps":["trace[1404743931] 'process raft request'  (duration: 244.277213ms)","trace[1404743931] 'compare'  (duration: 51.105712ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:55:54.200181Z","caller":"traceutil/trace.go:171","msg":"trace[574196043] transaction","detail":"{read_only:false; response_revision:37560; number_of_response:1; }","duration":"247.429949ms","start":"2026-09-11T18:55:53.952716Z","end":"2026-09-11T18:55:54.200146Z","steps":["trace[574196043] 'process raft request'  (duration: 246.824986ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:55:54.713699Z","caller":"traceutil/trace.go:171","msg":"trace[354999566] transaction","detail":"{read_only:false; response_revision:37565; number_of_response:1; }","duration":"247.611484ms","start":"2026-09-11T18:55:54.466049Z","end":"2026-09-11T18:55:54.71366Z","steps":["trace[354999566] 'process raft request'  (duration: 247.350938ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:55:54.760464Z","caller":"traceutil/trace.go:171","msg":"trace[1768779135] linearizableReadLoop","detail":"{readStateIndex:38743; appliedIndex:38741; }","duration":"229.635379ms","start":"2026-09-11T18:55:54.530803Z","end":"2026-09-11T18:55:54.760438Z","steps":["trace[1768779135] 'read index received'  (duration: 182.559702ms)","trace[1768779135] 'applied index is now lower than readState.Index'  (duration: 47.074707ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:55:54.760884Z","caller":"traceutil/trace.go:171","msg":"trace[702060450] transaction","detail":"{read_only:false; response_revision:37566; number_of_response:1; }","duration":"262.086673ms","start":"2026-09-11T18:55:54.498772Z","end":"2026-09-11T18:55:54.760859Z","steps":["trace[702060450] 'process raft request'  (duration: 261.531851ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:55:54.760982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.460565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:55:54.761047Z","caller":"traceutil/trace.go:171","msg":"trace[1805542665] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:37566; }","duration":"200.606268ms","start":"2026-09-11T18:55:54.56042Z","end":"2026-09-11T18:55:54.761027Z","steps":["trace[1805542665] 'agreement among raft nodes before linearized reading'  (duration: 200.462185ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:55:54.76117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.341255ms","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-09-11T18:55:54.761263Z","caller":"traceutil/trace.go:171","msg":"trace[438443306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:37566; }","duration":"230.493848ms","start":"2026-09-11T18:55:54.530748Z","end":"2026-09-11T18:55:54.761242Z","steps":["trace[438443306] 'agreement among raft nodes before linearized reading'  (duration: 230.229932ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:55:54.868396Z","caller":"traceutil/trace.go:171","msg":"trace[474168326] transaction","detail":"{read_only:false; response_revision:37567; number_of_response:1; }","duration":"103.115865ms","start":"2026-09-11T18:55:54.765243Z","end":"2026-09-11T18:55:54.868359Z","steps":["trace[474168326] 'process raft request'  (duration: 49.939518ms)","trace[474168326] 'compare'  (duration: 53.013153ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:55:55.165789Z","caller":"traceutil/trace.go:171","msg":"trace[1279177371] linearizableReadLoop","detail":"{readStateIndex:38747; appliedIndex:38744; }","duration":"261.424299ms","start":"2026-09-11T18:55:54.904335Z","end":"2026-09-11T18:55:55.16576Z","steps":["trace[1279177371] 'read index received'  (duration: 21.99645ms)","trace[1279177371] 'applied index is now lower than readState.Index'  (duration: 239.426419ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:55:55.166003Z","caller":"traceutil/trace.go:171","msg":"trace[42715189] transaction","detail":"{read_only:false; response_revision:37569; number_of_response:1; }","duration":"292.661407ms","start":"2026-09-11T18:55:54.873311Z","end":"2026-09-11T18:55:55.165972Z","steps":["trace[42715189] 'process raft request'  (duration: 291.82309ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:55:55.166021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.657874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:55:55.166262Z","caller":"traceutil/trace.go:171","msg":"trace[545420005] transaction","detail":"{read_only:false; response_revision:37570; number_of_response:1; }","duration":"292.291038ms","start":"2026-09-11T18:55:54.873772Z","end":"2026-09-11T18:55:55.166063Z","steps":["trace[545420005] 'process raft request'  (duration: 291.847309ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:55:55.166313Z","caller":"traceutil/trace.go:171","msg":"trace[861259014] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:37570; }","duration":"261.95638ms","start":"2026-09-11T18:55:54.904326Z","end":"2026-09-11T18:55:55.166283Z","steps":["trace[861259014] 'agreement among raft nodes before linearized reading'  (duration: 261.591702ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:55:55.442233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.150226ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299255502 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:37530 > 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-09-11T18:55:55.442342Z","caller":"traceutil/trace.go:171","msg":"trace[559353822] transaction","detail":"{read_only:false; response_revision:37571; number_of_response:1; }","duration":"227.243949ms","start":"2026-09-11T18:55:55.215079Z","end":"2026-09-11T18:55:55.442323Z","steps":["trace[559353822] 'process raft request'  (duration: 94.924659ms)","trace[559353822] 'compare'  (duration: 132.002682ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:55:59.035298Z","caller":"traceutil/trace.go:171","msg":"trace[80882487] transaction","detail":"{read_only:false; response_revision:37596; number_of_response:1; }","duration":"107.219432ms","start":"2026-09-11T18:55:58.928055Z","end":"2026-09-11T18:55:59.035274Z","steps":["trace[80882487] 'process raft request'  (duration: 106.077918ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:56:01.505745Z","caller":"traceutil/trace.go:171","msg":"trace[708567280] linearizableReadLoop","detail":"{readStateIndex:38792; appliedIndex:38790; }","duration":"170.598468ms","start":"2026-09-11T18:56:01.3351Z","end":"2026-09-11T18:56:01.505698Z","steps":["trace[708567280] 'read index received'  (duration: 81.284038ms)","trace[708567280] 'applied index is now lower than readState.Index'  (duration: 89.3123ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:56:01.50605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.909244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"info","ts":"2026-09-11T18:56:01.506171Z","caller":"traceutil/trace.go:171","msg":"trace[1327149106] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:37613; }","duration":"171.058937ms","start":"2026-09-11T18:56:01.335082Z","end":"2026-09-11T18:56:01.506141Z","steps":["trace[1327149106] 'agreement among raft nodes before linearized reading'  (duration: 170.820822ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:56:04.100416Z","caller":"traceutil/trace.go:171","msg":"trace[1223641636] transaction","detail":"{read_only:false; response_revision:37629; number_of_response:1; }","duration":"159.764986ms","start":"2026-09-11T18:56:03.940627Z","end":"2026-09-11T18:56:04.100392Z","steps":["trace[1223641636] 'process raft request'  (duration: 159.614163ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:56:06.294366Z","caller":"traceutil/trace.go:171","msg":"trace[1430084460] transaction","detail":"{read_only:false; response_revision:37645; number_of_response:1; }","duration":"133.186837ms","start":"2026-09-11T18:56:06.161131Z","end":"2026-09-11T18:56:06.294317Z","steps":["trace[1430084460] 'process raft request'  (duration: 107.059839ms)","trace[1430084460] 'compare'  (duration: 25.895223ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-11T18:56:06.850012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.55609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:56:06.850115Z","caller":"traceutil/trace.go:171","msg":"trace[1698461302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:37649; }","duration":"173.713174ms","start":"2026-09-11T18:56:06.676375Z","end":"2026-09-11T18:56:06.850088Z","steps":["trace[1698461302] 'agreement among raft nodes before linearized reading'  (duration: 51.647154ms)","trace[1698461302] 'range keys from in-memory index tree'  (duration: 121.910497ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:56:06.870618Z","caller":"traceutil/trace.go:171","msg":"trace[2084191609] transaction","detail":"{read_only:false; response_revision:37650; number_of_response:1; }","duration":"145.829268ms","start":"2026-09-11T18:56:06.724763Z","end":"2026-09-11T18:56:06.870592Z","steps":["trace[2084191609] 'process raft request'  (duration: 145.636824ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:56:06.914726Z","caller":"traceutil/trace.go:171","msg":"trace[290187182] transaction","detail":"{read_only:false; response_revision:37651; number_of_response:1; }","duration":"185.000365ms","start":"2026-09-11T18:56:06.729702Z","end":"2026-09-11T18:56:06.914703Z","steps":["trace[290187182] 'process raft request'  (duration: 184.843582ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:56:07.616085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.747349ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16772144509299255704 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:37642 > 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-09-11T18:56:07.616469Z","caller":"traceutil/trace.go:171","msg":"trace[2051755677] transaction","detail":"{read_only:false; response_revision:37659; number_of_response:1; }","duration":"122.774064ms","start":"2026-09-11T18:56:07.493646Z","end":"2026-09-11T18:56:07.61642Z","steps":["trace[2051755677] 'process raft request'  (duration: 17.630127ms)","trace[2051755677] 'compare'  (duration: 104.644347ms)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:56:08.453467Z","caller":"traceutil/trace.go:171","msg":"trace[1053822970] linearizableReadLoop","detail":"{readStateIndex:38841; appliedIndex:38840; }","duration":"135.947795ms","start":"2026-09-11T18:56:08.317494Z","end":"2026-09-11T18:56:08.453441Z","steps":["trace[1053822970] 'read index received'  (duration: 135.759322ms)","trace[1053822970] 'applied index is now lower than readState.Index'  (duration: 187.503µs)"],"step_count":2}
{"level":"info","ts":"2026-09-11T18:56:08.45353Z","caller":"traceutil/trace.go:171","msg":"trace[668714891] transaction","detail":"{read_only:false; response_revision:37661; number_of_response:1; }","duration":"144.722134ms","start":"2026-09-11T18:56:08.30877Z","end":"2026-09-11T18:56:08.453492Z","steps":["trace[668714891] 'process raft request'  (duration: 144.520989ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-11T18:56:08.453652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.11353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-11T18:56:08.45377Z","caller":"traceutil/trace.go:171","msg":"trace[1166701806] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:37661; }","duration":"136.243433ms","start":"2026-09-11T18:56:08.317488Z","end":"2026-09-11T18:56:08.453731Z","steps":["trace[1166701806] 'agreement among raft nodes before linearized reading'  (duration: 136.047298ms)"],"step_count":1}
{"level":"info","ts":"2026-09-11T18:58:37.020372Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"328ca0518abde8c2","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-11T18:58:37.026387Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-09-11T18:58:37.026552Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-09-11T19:00:17.733634Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37293}
{"level":"info","ts":"2026-09-11T19:00:17.857942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37293,"took":"119.655809ms","hash":3514430993,"current-db-size-bytes":58515456,"current-db-size":"58 MB","current-db-size-in-use-bytes":32862208,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-09-11T19:00:17.857998Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3514430993,"revision":37293,"compact-revision":35003}
{"level":"info","ts":"2026-09-11T19:05:17.740216Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39609}
{"level":"info","ts":"2026-09-11T19:05:17.882013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39609,"took":"138.570705ms","hash":2755486968,"current-db-size-bytes":60637184,"current-db-size":"61 MB","current-db-size-in-use-bytes":32448512,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-11T19:05:17.882074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2755486968,"revision":39609,"compact-revision":37293}