{"level":"warn","ts":"2026-10-04T12:50:32.912712Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-04T12:50:32.912847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.148: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.148:2380","--initial-cluster=instance=https://162.253.55.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.148:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-04T12:50:32.913063Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-04T12:50:32.913093Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.148:2380"]}
{"level":"info","ts":"2026-10-04T12:50:32.913128Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-04T12:50:32.914844Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"]}
{"level":"info","ts":"2026-10-04T12:50:32.915104Z","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.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.148:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-04T12:50:32.920612Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.839153ms"}
{"level":"info","ts":"2026-10-04T12:50:32.928852Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6342599e225e01b","cluster-id":"8ad3da7aa894cc05"}
{"level":"info","ts":"2026-10-04T12:50:32.929074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=()"}
{"level":"info","ts":"2026-10-04T12:50:32.929135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 0"}
{"level":"info","ts":"2026-10-04T12:50:32.929204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6342599e225e01b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-04T12:50:32.929233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 1"}
{"level":"info","ts":"2026-10-04T12:50:32.929604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"}
{"level":"warn","ts":"2026-10-04T12:50:32.937128Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-04T12:50:32.939319Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-04T12:50:32.940894Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-10-04T12:50:32.943876Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6342599e225e01b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-04T12:50:32.944158Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6342599e225e01b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-04T12:50:32.944211Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-04T12:50:32.944311Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-04T12:50:32.944321Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-04T12:50:32.945768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"}
{"level":"info","ts":"2026-10-04T12:50:32.94594Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","added-peer-id":"a6342599e225e01b","added-peer-peer-urls":["https://162.253.55.148:2380"]}
{"level":"info","ts":"2026-10-04T12:50:32.950693Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-04T12:50:32.95094Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.148:2380"}
{"level":"info","ts":"2026-10-04T12:50:32.951041Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.148:2380"}
{"level":"info","ts":"2026-10-04T12:50:32.951221Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6342599e225e01b","initial-advertise-peer-urls":["https://162.253.55.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-04T12:50:32.951312Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-04T12:50:33.530407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b is starting a new election at term 1"}
{"level":"info","ts":"2026-10-04T12:50:33.530478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-04T12:50:33.530512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgPreVoteResp from a6342599e225e01b at term 1"}
{"level":"info","ts":"2026-10-04T12:50:33.53053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became candidate at term 2"}
{"level":"info","ts":"2026-10-04T12:50:33.530541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgVoteResp from a6342599e225e01b at term 2"}
{"level":"info","ts":"2026-10-04T12:50:33.530556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became leader at term 2"}
{"level":"info","ts":"2026-10-04T12:50:33.530575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6342599e225e01b elected leader a6342599e225e01b at term 2"}
{"level":"info","ts":"2026-10-04T12:50:33.531813Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6342599e225e01b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.148:2379]}","request-path":"/0/members/a6342599e225e01b/attributes","cluster-id":"8ad3da7aa894cc05","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-04T12:50:33.53198Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T12:50:33.532099Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-04T12:50:33.532253Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-04T12:50:33.532344Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-04T12:50:33.532443Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:33.533595Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:33.533702Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:33.533754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-04T12:50:33.535069Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.148:2379"}
{"level":"info","ts":"2026-10-04T12:50:33.536818Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-04T12:51:09.272918Z","caller":"traceutil/trace.go:171","msg":"trace[1815715597] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"196.108691ms","start":"2026-10-04T12:51:09.076786Z","end":"2026-10-04T12:51:09.272895Z","steps":["trace[1815715597] 'read index received'  (duration: 195.804604ms)","trace[1815715597] 'applied index is now lower than readState.Index'  (duration: 299.376µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T12:51:09.273028Z","caller":"traceutil/trace.go:171","msg":"trace[169519815] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"218.25049ms","start":"2026-10-04T12:51:09.054724Z","end":"2026-10-04T12:51:09.272975Z","steps":["trace[169519815] 'process raft request'  (duration: 217.983084ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:09.273133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.312455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T12:51:09.273272Z","caller":"traceutil/trace.go:171","msg":"trace[1706019774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"196.52283ms","start":"2026-10-04T12:51:09.076724Z","end":"2026-10-04T12:51:09.273247Z","steps":["trace[1706019774] 'agreement among raft nodes before linearized reading'  (duration: 196.307185ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:51:15.665383Z","caller":"traceutil/trace.go:171","msg":"trace[845721268] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"144.117297ms","start":"2026-10-04T12:51:15.521232Z","end":"2026-10-04T12:51:15.665349Z","steps":["trace[845721268] 'process raft request'  (duration: 143.351631ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:15.998384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.189878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f5v7q\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-10-04T12:51:15.998488Z","caller":"traceutil/trace.go:171","msg":"trace[1551268311] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f5v7q; range_end:; response_count:1; response_revision:626; }","duration":"258.344359ms","start":"2026-10-04T12:51:15.740108Z","end":"2026-10-04T12:51:15.998452Z","steps":["trace[1551268311] 'range keys from in-memory index tree'  (duration: 257.923962ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:15.999213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.144416ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940157965934 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:481 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T12:51:15.99934Z","caller":"traceutil/trace.go:171","msg":"trace[251204252] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"259.185399ms","start":"2026-10-04T12:51:15.740137Z","end":"2026-10-04T12:51:15.999322Z","steps":["trace[251204252] 'process raft request'  (duration: 82.301077ms)","trace[251204252] 'compare'  (duration: 176.000693ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T12:51:16.012337Z","caller":"traceutil/trace.go:171","msg":"trace[2048948958] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"240.700416ms","start":"2026-10-04T12:51:15.771607Z","end":"2026-10-04T12:51:16.012307Z","steps":["trace[2048948958] 'process raft request'  (duration: 240.585553ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:51:16.601037Z","caller":"traceutil/trace.go:171","msg":"trace[216749845] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"576.870267ms","start":"2026-10-04T12:51:16.024121Z","end":"2026-10-04T12:51:16.600992Z","steps":["trace[216749845] 'read index received'  (duration: 497.404622ms)","trace[216749845] 'applied index is now lower than readState.Index'  (duration: 79.463105ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T12:51:16.601069Z","caller":"traceutil/trace.go:171","msg":"trace[1424640032] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"584.674392ms","start":"2026-10-04T12:51:16.016346Z","end":"2026-10-04T12:51:16.601021Z","steps":["trace[1424640032] 'process raft request'  (duration: 505.273367ms)","trace[1424640032] 'compare'  (duration: 78.998687ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T12:51:16.601295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.161604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-10-04T12:51:16.60126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T12:51:16.016304Z","time spent":"584.854617ms","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-f5v7q\" mod_revision:515 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-f5v7q\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-f5v7q\" > >"}
{"level":"warn","ts":"2026-10-04T12:51:16.601323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.828404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T12:51:16.601362Z","caller":"traceutil/trace.go:171","msg":"trace[315563049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"577.267035ms","start":"2026-10-04T12:51:16.024081Z","end":"2026-10-04T12:51:16.601348Z","steps":["trace[315563049] 'agreement among raft nodes before linearized reading'  (duration: 577.01226ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:16.601426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T12:51:16.024059Z","time spent":"577.336777ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-10-04T12:51:16.601393Z","caller":"traceutil/trace.go:171","msg":"trace[691505819] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:629; }","duration":"575.984748ms","start":"2026-10-04T12:51:16.025387Z","end":"2026-10-04T12:51:16.601372Z","steps":["trace[691505819] 'agreement among raft nodes before linearized reading'  (duration: 575.828385ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:16.60158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T12:51:16.025378Z","time spent":"576.190333ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":29,"request content":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "}
{"level":"warn","ts":"2026-10-04T12:51:16.601686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.561168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T12:51:16.601876Z","caller":"traceutil/trace.go:171","msg":"trace[619270552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"525.797843ms","start":"2026-10-04T12:51:16.07604Z","end":"2026-10-04T12:51:16.601838Z","steps":["trace[619270552] 'agreement among raft nodes before linearized reading'  (duration: 525.437956ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:51:16.601981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T12:51:16.076008Z","time spent":"525.955667ms","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-04T12:52:01.150797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.857908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T12:52:01.150918Z","caller":"traceutil/trace.go:171","msg":"trace[1282179654] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1197; }","duration":"225.055602ms","start":"2026-10-04T12:52:00.925843Z","end":"2026-10-04T12:52:01.150899Z","steps":["trace[1282179654] 'count revisions from in-memory index tree'  (duration: 224.746295ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:52:48.500428Z","caller":"traceutil/trace.go:171","msg":"trace[366753303] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"260.312709ms","start":"2026-10-04T12:52:48.240074Z","end":"2026-10-04T12:52:48.500386Z","steps":["trace[366753303] 'process raft request'  (duration: 259.989523ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:52:48.575038Z","caller":"traceutil/trace.go:171","msg":"trace[1492006976] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"307.699017ms","start":"2026-10-04T12:52:48.267314Z","end":"2026-10-04T12:52:48.575013Z","steps":["trace[1492006976] 'process raft request'  (duration: 307.492452ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:52:48.575193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T12:52:48.267277Z","time spent":"307.831279ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1799 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T12:52:48.575226Z","caller":"traceutil/trace.go:171","msg":"trace[1861446600] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"233.953434ms","start":"2026-10-04T12:52:48.341253Z","end":"2026-10-04T12:52:48.575206Z","steps":["trace[1861446600] 'process raft request'  (duration: 233.718339ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:52:48.825273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.870418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-10-04T12:52:48.825454Z","caller":"traceutil/trace.go:171","msg":"trace[154194165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1859; }","duration":"225.087473ms","start":"2026-10-04T12:52:48.600297Z","end":"2026-10-04T12:52:48.825384Z","steps":["trace[154194165] 'range keys from in-memory index tree'  (duration: 224.615962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:53:32.964437Z","caller":"traceutil/trace.go:171","msg":"trace[335600268] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"128.339106ms","start":"2026-10-04T12:53:32.836073Z","end":"2026-10-04T12:53:32.964412Z","steps":["trace[335600268] 'process raft request'  (duration: 123.622905ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:53:44.536133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.842763ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940157969199 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2206 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T12:53:44.536266Z","caller":"traceutil/trace.go:171","msg":"trace[1751524272] linearizableReadLoop","detail":"{readStateIndex:2305; appliedIndex:2304; }","duration":"181.783489ms","start":"2026-10-04T12:53:44.354462Z","end":"2026-10-04T12:53:44.536246Z","steps":["trace[1751524272] 'read index received'  (duration: 77.6718ms)","trace[1751524272] 'applied index is now lower than readState.Index'  (duration: 104.110209ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T12:53:44.536326Z","caller":"traceutil/trace.go:171","msg":"trace[1520757596] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"201.218817ms","start":"2026-10-04T12:53:44.335086Z","end":"2026-10-04T12:53:44.536305Z","steps":["trace[1520757596] 'process raft request'  (duration: 97.093318ms)","trace[1520757596] 'compare'  (duration: 103.68927ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T12:53:44.536361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.889901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T12:53:44.536397Z","caller":"traceutil/trace.go:171","msg":"trace[2121637204] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2216; }","duration":"181.948442ms","start":"2026-10-04T12:53:44.354436Z","end":"2026-10-04T12:53:44.536384Z","steps":["trace[2121637204] 'agreement among raft nodes before linearized reading'  (duration: 181.866601ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:54:36.366441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.876147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T12:54:36.366546Z","caller":"traceutil/trace.go:171","msg":"trace[97459714] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2666; }","duration":"159.0121ms","start":"2026-10-04T12:54:36.207505Z","end":"2026-10-04T12:54:36.366517Z","steps":["trace[97459714] 'range keys from in-memory index tree'  (duration: 158.788956ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T12:55:09.181683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.792344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T12:55:09.181789Z","caller":"traceutil/trace.go:171","msg":"trace[326432701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2866; }","duration":"104.956077ms","start":"2026-10-04T12:55:09.076812Z","end":"2026-10-04T12:55:09.181768Z","steps":["trace[326432701] 'range keys from in-memory index tree'  (duration: 104.668191ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T12:55:09.583226Z","caller":"traceutil/trace.go:171","msg":"trace[1840573474] transaction","detail":"{read_only:false; response_revision:2868; number_of_response:1; }","duration":"153.561523ms","start":"2026-10-04T12:55:09.429607Z","end":"2026-10-04T12:55:09.583169Z","steps":["trace[1840573474] 'process raft request'  (duration: 100.297647ms)","trace[1840573474] 'compare'  (duration: 52.962829ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:02.861356Z","caller":"traceutil/trace.go:171","msg":"trace[860420257] linearizableReadLoop","detail":"{readStateIndex:5553; appliedIndex:5552; }","duration":"306.497171ms","start":"2026-10-04T13:00:02.554835Z","end":"2026-10-04T13:00:02.861332Z","steps":["trace[860420257] 'read index received'  (duration: 306.352397ms)","trace[860420257] 'applied index is now lower than readState.Index'  (duration: 143.614µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:02.861486Z","caller":"traceutil/trace.go:171","msg":"trace[1265010374] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"307.001511ms","start":"2026-10-04T13:00:02.554447Z","end":"2026-10-04T13:00:02.861448Z","steps":["trace[1265010374] 'process raft request'  (duration: 306.698695ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:02.861674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:00:02.554424Z","time spent":"307.164905ms","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3700,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af494d54-2fc7-49ba-9508-c58db9682ec9\" mod_revision:5315 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af494d54-2fc7-49ba-9508-c58db9682ec9\" value_size:3600 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af494d54-2fc7-49ba-9508-c58db9682ec9\" > >"}
{"level":"warn","ts":"2026-10-04T13:00:02.862293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.441961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786932"}
{"level":"info","ts":"2026-10-04T13:00:02.86236Z","caller":"traceutil/trace.go:171","msg":"trace[1650425009] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5345; }","duration":"307.517732ms","start":"2026-10-04T13:00:02.554829Z","end":"2026-10-04T13:00:02.862346Z","steps":["trace[1650425009] 'agreement among raft nodes before linearized reading'  (duration: 306.662394ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:02.862433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:00:02.554785Z","time spent":"307.635515ms","remote":"127.0.0.1:36646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":786956,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "}
{"level":"warn","ts":"2026-10-04T13:00:02.898937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.717612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"}
{"level":"info","ts":"2026-10-04T13:00:02.899049Z","caller":"traceutil/trace.go:171","msg":"trace[1551142331] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5347; }","duration":"178.869224ms","start":"2026-10-04T13:00:02.720138Z","end":"2026-10-04T13:00:02.899008Z","steps":["trace[1551142331] 'agreement among raft nodes before linearized reading'  (duration: 178.630839ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:02.899366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.130664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-04T13:00:02.899348Z","caller":"traceutil/trace.go:171","msg":"trace[835113713] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"163.896181ms","start":"2026-10-04T13:00:02.735411Z","end":"2026-10-04T13:00:02.899307Z","steps":["trace[835113713] 'process raft request'  (duration: 163.314268ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:02.899412Z","caller":"traceutil/trace.go:171","msg":"trace[12855619] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5347; }","duration":"145.191396ms","start":"2026-10-04T13:00:02.754207Z","end":"2026-10-04T13:00:02.899398Z","steps":["trace[12855619] 'agreement among raft nodes before linearized reading'  (duration: 145.075103ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:02.899474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.436841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-95c9b-tls\" ","response":"range_response_count:1 size:2184"}
{"level":"info","ts":"2026-10-04T13:00:02.899459Z","caller":"traceutil/trace.go:171","msg":"trace[2030080487] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"284.209508ms","start":"2026-10-04T13:00:02.615203Z","end":"2026-10-04T13:00:02.899413Z","steps":["trace[2030080487] 'process raft request'  (duration: 283.39815ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:02.899525Z","caller":"traceutil/trace.go:171","msg":"trace[1567172391] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-95c9b-tls; range_end:; response_count:1; response_revision:5347; }","duration":"151.519213ms","start":"2026-10-04T13:00:02.747991Z","end":"2026-10-04T13:00:02.89951Z","steps":["trace[1567172391] 'agreement among raft nodes before linearized reading'  (duration: 151.371271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:00:04.858867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.686303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786932"}
{"level":"info","ts":"2026-10-04T13:00:04.858956Z","caller":"traceutil/trace.go:171","msg":"trace[1558452352] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5365; }","duration":"145.832017ms","start":"2026-10-04T13:00:04.713103Z","end":"2026-10-04T13:00:04.858935Z","steps":["trace[1558452352] 'range keys from in-memory index tree'  (duration: 145.220584ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:08.897732Z","caller":"traceutil/trace.go:171","msg":"trace[396838724] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"143.883014ms","start":"2026-10-04T13:00:08.753818Z","end":"2026-10-04T13:00:08.897701Z","steps":["trace[396838724] 'process raft request'  (duration: 65.650941ms)","trace[396838724] 'compare'  (duration: 78.111121ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:08.897906Z","caller":"traceutil/trace.go:171","msg":"trace[968853293] linearizableReadLoop","detail":"{readStateIndex:5655; appliedIndex:5654; }","duration":"100.106503ms","start":"2026-10-04T13:00:08.797753Z","end":"2026-10-04T13:00:08.897859Z","steps":["trace[968853293] 'read index received'  (duration: 21.736718ms)","trace[968853293] 'applied index is now lower than readState.Index'  (duration: 78.365965ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:00:08.898195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.424519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-10-04T13:00:08.898243Z","caller":"traceutil/trace.go:171","msg":"trace[1381361973] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5444; }","duration":"100.488701ms","start":"2026-10-04T13:00:08.797738Z","end":"2026-10-04T13:00:08.898227Z","steps":["trace[1381361973] 'agreement among raft nodes before linearized reading'  (duration: 100.246155ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:17.113571Z","caller":"traceutil/trace.go:171","msg":"trace[1030262788] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"117.337744ms","start":"2026-10-04T13:00:16.996206Z","end":"2026-10-04T13:00:17.113544Z","steps":["trace[1030262788] 'process raft request'  (duration: 29.354581ms)","trace[1030262788] 'compare'  (duration: 87.757858ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:17.320451Z","caller":"traceutil/trace.go:171","msg":"trace[1682848860] linearizableReadLoop","detail":"{readStateIndex:5812; appliedIndex:5811; }","duration":"169.904194ms","start":"2026-10-04T13:00:17.150526Z","end":"2026-10-04T13:00:17.32043Z","steps":["trace[1682848860] 'read index received'  (duration: 128.921153ms)","trace[1682848860] 'applied index is now lower than readState.Index'  (duration: 40.982021ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:00:17.320562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.016677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:00:17.320595Z","caller":"traceutil/trace.go:171","msg":"trace[1346484616] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:5596; }","duration":"170.094419ms","start":"2026-10-04T13:00:17.150491Z","end":"2026-10-04T13:00:17.320585Z","steps":["trace[1346484616] 'agreement among raft nodes before linearized reading'  (duration: 170.015177ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:00:17.320618Z","caller":"traceutil/trace.go:171","msg":"trace[153022412] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"203.234931ms","start":"2026-10-04T13:00:17.117324Z","end":"2026-10-04T13:00:17.320559Z","steps":["trace[153022412] 'process raft request'  (duration: 162.065725ms)","trace[153022412] 'compare'  (duration: 40.918461ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:00:33.581341Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3001}
{"level":"info","ts":"2026-10-04T13:00:33.672924Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3001,"took":"90.19156ms","hash":2595496337,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":30007296,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-04T13:00:33.673Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2595496337,"revision":3001,"compact-revision":-1}
{"level":"info","ts":"2026-10-04T13:05:33.595618Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5905}
{"level":"info","ts":"2026-10-04T13:05:33.695008Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5905,"took":"97.199646ms","hash":3681909111,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":26128384,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-04T13:05:33.695104Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3681909111,"revision":5905,"compact-revision":3001}
{"level":"info","ts":"2026-10-04T13:06:34.761008Z","caller":"traceutil/trace.go:171","msg":"trace[240525113] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"111.538816ms","start":"2026-10-04T13:06:34.649436Z","end":"2026-10-04T13:06:34.760975Z","steps":["trace[240525113] 'process raft request'  (duration: 111.323462ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:42.948576Z","caller":"traceutil/trace.go:171","msg":"trace[1543886885] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"218.176056ms","start":"2026-10-04T13:06:42.730379Z","end":"2026-10-04T13:06:42.948555Z","steps":["trace[1543886885] 'process raft request'  (duration: 218.001783ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:42.949792Z","caller":"traceutil/trace.go:171","msg":"trace[1817916244] transaction","detail":"{read_only:false; response_revision:8656; number_of_response:1; }","duration":"157.005193ms","start":"2026-10-04T13:06:42.792761Z","end":"2026-10-04T13:06:42.949767Z","steps":["trace[1817916244] 'process raft request'  (duration: 156.814899ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:42.950053Z","caller":"traceutil/trace.go:171","msg":"trace[1317174754] linearizableReadLoop","detail":"{readStateIndex:8970; appliedIndex:8967; }","duration":"149.096592ms","start":"2026-10-04T13:06:42.800934Z","end":"2026-10-04T13:06:42.950031Z","steps":["trace[1317174754] 'read index received'  (duration: 147.457727ms)","trace[1317174754] 'applied index is now lower than readState.Index'  (duration: 1.637215ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:06:42.950139Z","caller":"traceutil/trace.go:171","msg":"trace[55865116] transaction","detail":"{read_only:false; response_revision:8657; number_of_response:1; }","duration":"150.991233ms","start":"2026-10-04T13:06:42.799131Z","end":"2026-10-04T13:06:42.950122Z","steps":["trace[55865116] 'process raft request'  (duration: 150.588264ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:42.950329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.381739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-10-04T13:06:42.950399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.15818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ttwvw\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-04T13:06:42.950411Z","caller":"traceutil/trace.go:171","msg":"trace[274921031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8658; }","duration":"149.518432ms","start":"2026-10-04T13:06:42.800875Z","end":"2026-10-04T13:06:42.950393Z","steps":["trace[274921031] 'agreement among raft nodes before linearized reading'  (duration: 149.294537ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:42.950477Z","caller":"traceutil/trace.go:171","msg":"trace[601706721] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ttwvw; range_end:; response_count:1; response_revision:8658; }","duration":"113.249893ms","start":"2026-10-04T13:06:42.837187Z","end":"2026-10-04T13:06:42.950437Z","steps":["trace[601706721] 'agreement among raft nodes before linearized reading'  (duration: 113.09174ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:54.678578Z","caller":"traceutil/trace.go:171","msg":"trace[653433475] linearizableReadLoop","detail":"{readStateIndex:9031; appliedIndex:9030; }","duration":"114.630493ms","start":"2026-10-04T13:06:54.56392Z","end":"2026-10-04T13:06:54.678551Z","steps":["trace[653433475] 'read index received'  (duration: 114.566441ms)","trace[653433475] 'applied index is now lower than readState.Index'  (duration: 63.111µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:06:54.678777Z","caller":"traceutil/trace.go:171","msg":"trace[42084766] transaction","detail":"{read_only:false; response_revision:8716; number_of_response:1; }","duration":"227.67102ms","start":"2026-10-04T13:06:54.451087Z","end":"2026-10-04T13:06:54.678758Z","steps":["trace[42084766] 'process raft request'  (duration: 227.282822ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:54.678969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.025051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T13:06:54.679014Z","caller":"traceutil/trace.go:171","msg":"trace[314904326] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:8716; }","duration":"115.131093ms","start":"2026-10-04T13:06:54.56387Z","end":"2026-10-04T13:06:54.679001Z","steps":["trace[314904326] 'agreement among raft nodes before linearized reading'  (duration: 115.041561ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:06:54.695901Z","caller":"traceutil/trace.go:171","msg":"trace[1095201222] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"116.497183ms","start":"2026-10-04T13:06:54.579363Z","end":"2026-10-04T13:06:54.69586Z","steps":["trace[1095201222] 'process raft request'  (duration: 116.040513ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:55.359917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.523395ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940157985872 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8711 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-04T13:06:55.36006Z","caller":"traceutil/trace.go:171","msg":"trace[1997912300] linearizableReadLoop","detail":"{readStateIndex:9037; appliedIndex:9036; }","duration":"283.594571ms","start":"2026-10-04T13:06:55.076444Z","end":"2026-10-04T13:06:55.360039Z","steps":["trace[1997912300] 'read index received'  (duration: 36.752869ms)","trace[1997912300] 'applied index is now lower than readState.Index'  (duration: 246.840112ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:06:55.360136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.729975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:06:55.360136Z","caller":"traceutil/trace.go:171","msg":"trace[264820795] transaction","detail":"{read_only:false; response_revision:8722; number_of_response:1; }","duration":"304.710805ms","start":"2026-10-04T13:06:55.055386Z","end":"2026-10-04T13:06:55.360097Z","steps":["trace[264820795] 'process raft request'  (duration: 57.897003ms)","trace[264820795] 'compare'  (duration: 246.22707ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:06:55.360178Z","caller":"traceutil/trace.go:171","msg":"trace[1828937560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8722; }","duration":"283.793946ms","start":"2026-10-04T13:06:55.076369Z","end":"2026-10-04T13:06:55.360163Z","steps":["trace[1828937560] 'agreement among raft nodes before linearized reading'  (duration: 283.726125ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:55.360316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:06:55.055357Z","time spent":"304.841148ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8711 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-04T13:06:56.027694Z","caller":"traceutil/trace.go:171","msg":"trace[339939051] linearizableReadLoop","detail":"{readStateIndex:9041; appliedIndex:9040; }","duration":"111.740349ms","start":"2026-10-04T13:06:55.915919Z","end":"2026-10-04T13:06:56.02766Z","steps":["trace[339939051] 'read index received'  (duration: 93.930047ms)","trace[339939051] 'applied index is now lower than readState.Index'  (duration: 17.808522ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:06:56.027819Z","caller":"traceutil/trace.go:171","msg":"trace[1736017612] transaction","detail":"{read_only:false; response_revision:8726; number_of_response:1; }","duration":"159.596058ms","start":"2026-10-04T13:06:55.86813Z","end":"2026-10-04T13:06:56.027726Z","steps":["trace[1736017612] 'process raft request'  (duration: 141.799706ms)","trace[1736017612] 'compare'  (duration: 17.547927ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:06:56.027922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.334262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-04T13:06:56.027966Z","caller":"traceutil/trace.go:171","msg":"trace[1186423969] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8726; }","duration":"105.450305ms","start":"2026-10-04T13:06:55.922502Z","end":"2026-10-04T13:06:56.027952Z","steps":["trace[1186423969] 'agreement among raft nodes before linearized reading'  (duration: 105.338292ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:56.028025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.092988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-04T13:06:56.028149Z","caller":"traceutil/trace.go:171","msg":"trace[1353922815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8726; }","duration":"112.293772ms","start":"2026-10-04T13:06:55.915825Z","end":"2026-10-04T13:06:56.028119Z","steps":["trace[1353922815] 'agreement among raft nodes before linearized reading'  (duration: 111.984895ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:06:56.028337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.934155ms","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-10-04T13:06:56.028441Z","caller":"traceutil/trace.go:171","msg":"trace[1837043087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8726; }","duration":"105.109658ms","start":"2026-10-04T13:06:55.923289Z","end":"2026-10-04T13:06:56.028399Z","steps":["trace[1837043087] 'agreement among raft nodes before linearized reading'  (duration: 104.671458ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:26.347778Z","caller":"traceutil/trace.go:171","msg":"trace[1179902432] linearizableReadLoop","detail":"{readStateIndex:9265; appliedIndex:9264; }","duration":"111.627629ms","start":"2026-10-04T13:07:26.236125Z","end":"2026-10-04T13:07:26.347753Z","steps":["trace[1179902432] 'read index received'  (duration: 111.436784ms)","trace[1179902432] 'applied index is now lower than readState.Index'  (duration: 189.404µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:07:26.348012Z","caller":"traceutil/trace.go:171","msg":"trace[1827516856] transaction","detail":"{read_only:false; response_revision:8941; number_of_response:1; }","duration":"124.708759ms","start":"2026-10-04T13:07:26.223247Z","end":"2026-10-04T13:07:26.347956Z","steps":["trace[1827516856] 'process raft request'  (duration: 124.2906ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:07:26.348271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.098719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-04T13:07:26.348547Z","caller":"traceutil/trace.go:171","msg":"trace[882263741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8941; }","duration":"112.433715ms","start":"2026-10-04T13:07:26.236097Z","end":"2026-10-04T13:07:26.348531Z","steps":["trace[882263741] 'agreement among raft nodes before linearized reading'  (duration: 111.76225ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:26.514249Z","caller":"traceutil/trace.go:171","msg":"trace[773378898] transaction","detail":"{read_only:false; response_revision:8942; number_of_response:1; }","duration":"160.727233ms","start":"2026-10-04T13:07:26.353459Z","end":"2026-10-04T13:07:26.514186Z","steps":["trace[773378898] 'process raft request'  (duration: 108.976481ms)","trace[773378898] 'compare'  (duration: 51.580198ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:07:39.464398Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002482.wal"}
{"level":"info","ts":"2026-10-04T13:07:39.972111Z","caller":"traceutil/trace.go:171","msg":"trace[991403775] linearizableReadLoop","detail":"{readStateIndex:9350; appliedIndex:9349; }","duration":"103.353758ms","start":"2026-10-04T13:07:39.868727Z","end":"2026-10-04T13:07:39.972081Z","steps":["trace[991403775] 'read index received'  (duration: 103.091953ms)","trace[991403775] 'applied index is now lower than readState.Index'  (duration: 260.825µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:07:39.972315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.538232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-10-04T13:07:39.972368Z","caller":"traceutil/trace.go:171","msg":"trace[1867698086] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9023; }","duration":"103.693156ms","start":"2026-10-04T13:07:39.868662Z","end":"2026-10-04T13:07:39.972356Z","steps":["trace[1867698086] 'agreement among raft nodes before linearized reading'  (duration: 103.540792ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:07:39.972179Z","caller":"traceutil/trace.go:171","msg":"trace[358272485] transaction","detail":"{read_only:false; response_revision:9023; number_of_response:1; }","duration":"139.421653ms","start":"2026-10-04T13:07:39.83272Z","end":"2026-10-04T13:07:39.972141Z","steps":["trace[358272485] 'process raft request'  (duration: 139.149887ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:08:41.482695Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T13:08:41.491279Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-04T13:08:41.491449Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-04T13:09:07.229448Z","caller":"traceutil/trace.go:171","msg":"trace[1982679641] linearizableReadLoop","detail":"{readStateIndex:10212; appliedIndex:10211; }","duration":"268.620041ms","start":"2026-10-04T13:09:06.960776Z","end":"2026-10-04T13:09:07.229396Z","steps":["trace[1982679641] 'read index received'  (duration: 268.416927ms)","trace[1982679641] 'applied index is now lower than readState.Index'  (duration: 201.934µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:09:07.229514Z","caller":"traceutil/trace.go:171","msg":"trace[1707851692] transaction","detail":"{read_only:false; response_revision:9858; number_of_response:1; }","duration":"269.798767ms","start":"2026-10-04T13:09:06.95967Z","end":"2026-10-04T13:09:07.229468Z","steps":["trace[1707851692] 'process raft request'  (duration: 269.549962ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:09:07.229758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.952489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-04T13:09:07.229852Z","caller":"traceutil/trace.go:171","msg":"trace[54961084] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:9858; }","duration":"269.080741ms","start":"2026-10-04T13:09:06.960751Z","end":"2026-10-04T13:09:07.229832Z","steps":["trace[54961084] 'agreement among raft nodes before linearized reading'  (duration: 268.808185ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:10:33.603231Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8060}
{"level":"info","ts":"2026-10-04T13:10:33.671202Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8060,"took":"65.556168ms","hash":3144438003,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":28405760,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T13:10:33.67127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3144438003,"revision":8060,"compact-revision":5905}
{"level":"info","ts":"2026-10-04T13:15:33.612506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10448}
{"level":"info","ts":"2026-10-04T13:15:33.704633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10448,"took":"88.129473ms","hash":2300990128,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":25755648,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-04T13:15:33.704703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2300990128,"revision":10448,"compact-revision":8060}
{"level":"info","ts":"2026-10-04T13:20:33.620629Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12629}
{"level":"info","ts":"2026-10-04T13:20:33.724107Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12629,"took":"100.23965ms","hash":2609760648,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":27885568,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-04T13:20:33.724351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2609760648,"revision":12629,"compact-revision":10448}
{"level":"info","ts":"2026-10-04T13:21:35.230272Z","caller":"traceutil/trace.go:171","msg":"trace[794157733] linearizableReadLoop","detail":"{readStateIndex:15661; appliedIndex:15660; }","duration":"149.12996ms","start":"2026-10-04T13:21:35.081113Z","end":"2026-10-04T13:21:35.230243Z","steps":["trace[794157733] 'read index received'  (duration: 148.882125ms)","trace[794157733] 'applied index is now lower than readState.Index'  (duration: 246.915µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:21:35.230368Z","caller":"traceutil/trace.go:171","msg":"trace[1494026524] transaction","detail":"{read_only:false; response_revision:15129; number_of_response:1; }","duration":"155.228063ms","start":"2026-10-04T13:21:35.075078Z","end":"2026-10-04T13:21:35.230306Z","steps":["trace[1494026524] 'process raft request'  (duration: 154.973157ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:21:35.230583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.441587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:21:35.230705Z","caller":"traceutil/trace.go:171","msg":"trace[1204292668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15129; }","duration":"149.60613ms","start":"2026-10-04T13:21:35.081056Z","end":"2026-10-04T13:21:35.230662Z","steps":["trace[1204292668] 'agreement among raft nodes before linearized reading'  (duration: 149.310744ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:21:35.561971Z","caller":"traceutil/trace.go:171","msg":"trace[637849037] transaction","detail":"{read_only:false; response_revision:15131; number_of_response:1; }","duration":"270.175866ms","start":"2026-10-04T13:21:35.291761Z","end":"2026-10-04T13:21:35.561937Z","steps":["trace[637849037] 'process raft request'  (duration: 254.642256ms)","trace[637849037] 'compare'  (duration: 15.066059ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:22:44.040154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.843623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:22:44.040225Z","caller":"traceutil/trace.go:171","msg":"trace[113740874] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16054; }","duration":"123.010376ms","start":"2026-10-04T13:22:43.917198Z","end":"2026-10-04T13:22:44.040209Z","steps":["trace[113740874] 'range keys from in-memory index tree'  (duration: 122.67928ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:22:44.040444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.421575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-10-04T13:22:44.040463Z","caller":"traceutil/trace.go:171","msg":"trace[163501538] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16054; }","duration":"124.561487ms","start":"2026-10-04T13:22:43.915896Z","end":"2026-10-04T13:22:44.040457Z","steps":["trace[163501538] 'range keys from in-memory index tree'  (duration: 124.282732ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:22:44.040551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.812354ms","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-10-04T13:22:44.040662Z","caller":"traceutil/trace.go:171","msg":"trace[90782751] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16054; }","duration":"118.955125ms","start":"2026-10-04T13:22:43.921681Z","end":"2026-10-04T13:22:44.040636Z","steps":["trace[90782751] 'range keys from in-memory index tree'  (duration: 118.677182ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:23:08.167678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.145979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ttwvw\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-04T13:23:08.16778Z","caller":"traceutil/trace.go:171","msg":"trace[2138222735] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ttwvw; range_end:; response_count:1; response_revision:16181; }","duration":"124.306952ms","start":"2026-10-04T13:23:08.043453Z","end":"2026-10-04T13:23:08.16776Z","steps":["trace[2138222735] 'range keys from in-memory index tree'  (duration: 124.006065ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:23:08.16801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.932298ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-04T13:23:08.168074Z","caller":"traceutil/trace.go:171","msg":"trace[879442067] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:16181; }","duration":"106.001189ms","start":"2026-10-04T13:23:08.062066Z","end":"2026-10-04T13:23:08.168068Z","steps":["trace[879442067] 'range keys from in-memory index tree'  (duration: 105.922988ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:25:33.628357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14668}
{"level":"info","ts":"2026-10-04T13:25:33.717888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14668,"took":"85.773954ms","hash":1587588552,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":32071680,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-04T13:25:33.717981Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1587588552,"revision":14668,"compact-revision":12629}
{"level":"info","ts":"2026-10-04T13:28:59.456033Z","caller":"traceutil/trace.go:171","msg":"trace[1238441895] linearizableReadLoop","detail":"{readStateIndex:19420; appliedIndex:19419; }","duration":"112.288791ms","start":"2026-10-04T13:28:59.343722Z","end":"2026-10-04T13:28:59.456011Z","steps":["trace[1238441895] 'read index received'  (duration: 22.583648ms)","trace[1238441895] 'applied index is now lower than readState.Index'  (duration: 89.703923ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:28:59.45606Z","caller":"traceutil/trace.go:171","msg":"trace[929251862] transaction","detail":"{read_only:false; response_revision:18772; number_of_response:1; }","duration":"174.553444ms","start":"2026-10-04T13:28:59.281471Z","end":"2026-10-04T13:28:59.456024Z","steps":["trace[929251862] 'process raft request'  (duration: 84.88698ms)","trace[929251862] 'compare'  (duration: 89.531461ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:28:59.4562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.462245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-4cndt\" ","response":"range_response_count:1 size:9800"}
{"level":"info","ts":"2026-10-04T13:28:59.456226Z","caller":"traceutil/trace.go:171","msg":"trace[1457177595] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-4cndt; range_end:; response_count:1; response_revision:18772; }","duration":"112.556197ms","start":"2026-10-04T13:28:59.343662Z","end":"2026-10-04T13:28:59.456218Z","steps":["trace[1457177595] 'agreement among raft nodes before linearized reading'  (duration: 112.426114ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:29:03.418454Z","caller":"traceutil/trace.go:171","msg":"trace[343883645] transaction","detail":"{read_only:false; response_revision:18862; number_of_response:1; }","duration":"112.774523ms","start":"2026-10-04T13:29:03.305649Z","end":"2026-10-04T13:29:03.418424Z","steps":["trace[343883645] 'process raft request'  (duration: 37.987039ms)","trace[343883645] 'compare'  (duration: 74.64491ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:29:43.093778Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T13:29:43.102772Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-04T13:29:43.102929Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-04T13:30:33.638154Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17169}
{"level":"info","ts":"2026-10-04T13:30:33.741105Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17169,"took":"98.302329ms","hash":793474812,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":34054144,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-04T13:30:33.741173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":793474812,"revision":17169,"compact-revision":14668}
{"level":"warn","ts":"2026-10-04T13:34:31.396828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.249888ms","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-10-04T13:34:31.396941Z","caller":"traceutil/trace.go:171","msg":"trace[1296453246] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:21375; }","duration":"134.438981ms","start":"2026-10-04T13:34:31.262476Z","end":"2026-10-04T13:34:31.396915Z","steps":["trace[1296453246] 'count revisions from in-memory index tree'  (duration: 134.148755ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:34:36.944309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.98114ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158025325 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:21391 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:34:36.944534Z","caller":"traceutil/trace.go:171","msg":"trace[1772358371] transaction","detail":"{read_only:false; response_revision:21401; number_of_response:1; }","duration":"289.842179ms","start":"2026-10-04T13:34:36.654671Z","end":"2026-10-04T13:34:36.944514Z","steps":["trace[1772358371] 'process raft request'  (duration: 289.784818ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:36.944632Z","caller":"traceutil/trace.go:171","msg":"trace[752695041] transaction","detail":"{read_only:false; response_revision:21400; number_of_response:1; }","duration":"292.65545ms","start":"2026-10-04T13:34:36.651955Z","end":"2026-10-04T13:34:36.944611Z","steps":["trace[752695041] 'process raft request'  (duration: 148.275693ms)","trace[752695041] 'compare'  (duration: 143.865066ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:34:58.638525Z","caller":"traceutil/trace.go:171","msg":"trace[1182130953] transaction","detail":"{read_only:false; response_revision:21512; number_of_response:1; }","duration":"199.034525ms","start":"2026-10-04T13:34:58.439464Z","end":"2026-10-04T13:34:58.638499Z","steps":["trace[1182130953] 'process raft request'  (duration: 198.879362ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:58.638733Z","caller":"traceutil/trace.go:171","msg":"trace[1998661530] linearizableReadLoop","detail":"{readStateIndex:22252; appliedIndex:22252; }","duration":"180.868283ms","start":"2026-10-04T13:34:58.457852Z","end":"2026-10-04T13:34:58.63872Z","steps":["trace[1998661530] 'read index received'  (duration: 180.862163ms)","trace[1998661530] 'applied index is now lower than readState.Index'  (duration: 5.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:34:58.63891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.053768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:34:58.638965Z","caller":"traceutil/trace.go:171","msg":"trace[501573521] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21512; }","duration":"181.159259ms","start":"2026-10-04T13:34:58.457793Z","end":"2026-10-04T13:34:58.638952Z","steps":["trace[501573521] 'agreement among raft nodes before linearized reading'  (duration: 180.994806ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:58.809591Z","caller":"traceutil/trace.go:171","msg":"trace[64521519] linearizableReadLoop","detail":"{readStateIndex:22255; appliedIndex:22252; }","duration":"115.70006ms","start":"2026-10-04T13:34:58.693871Z","end":"2026-10-04T13:34:58.809571Z","steps":["trace[64521519] 'read index received'  (duration: 55.191867ms)","trace[64521519] 'applied index is now lower than readState.Index'  (duration: 60.507313ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:34:58.809772Z","caller":"traceutil/trace.go:171","msg":"trace[1025638662] transaction","detail":"{read_only:false; response_revision:21513; number_of_response:1; }","duration":"235.166061ms","start":"2026-10-04T13:34:58.574581Z","end":"2026-10-04T13:34:58.809747Z","steps":["trace[1025638662] 'process raft request'  (duration: 174.499636ms)","trace[1025638662] 'compare'  (duration: 60.260037ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:34:58.809844Z","caller":"traceutil/trace.go:171","msg":"trace[1639871697] transaction","detail":"{read_only:false; response_revision:21514; number_of_response:1; }","duration":"227.58527ms","start":"2026-10-04T13:34:58.582209Z","end":"2026-10-04T13:34:58.809794Z","steps":["trace[1639871697] 'process raft request'  (duration: 227.271713ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:34:58.809942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.054938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:34:58.809982Z","caller":"traceutil/trace.go:171","msg":"trace[821338325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21515; }","duration":"116.14741ms","start":"2026-10-04T13:34:58.693826Z","end":"2026-10-04T13:34:58.809973Z","steps":["trace[821338325] 'agreement among raft nodes before linearized reading'  (duration: 115.826424ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:58.810031Z","caller":"traceutil/trace.go:171","msg":"trace[1292074160] transaction","detail":"{read_only:false; response_revision:21515; number_of_response:1; }","duration":"166.838141ms","start":"2026-10-04T13:34:58.64304Z","end":"2026-10-04T13:34:58.809878Z","steps":["trace[1292074160] 'process raft request'  (duration: 166.482623ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:59.037954Z","caller":"traceutil/trace.go:171","msg":"trace[439944581] linearizableReadLoop","detail":"{readStateIndex:22256; appliedIndex:22255; }","duration":"132.858109ms","start":"2026-10-04T13:34:58.905067Z","end":"2026-10-04T13:34:59.037925Z","steps":["trace[439944581] 'read index received'  (duration: 66.604233ms)","trace[439944581] 'applied index is now lower than readState.Index'  (duration: 66.252496ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:34:59.038226Z","caller":"traceutil/trace.go:171","msg":"trace[942370503] transaction","detail":"{read_only:false; response_revision:21516; number_of_response:1; }","duration":"223.272556ms","start":"2026-10-04T13:34:58.814915Z","end":"2026-10-04T13:34:59.038187Z","steps":["trace[942370503] 'process raft request'  (duration: 156.676963ms)","trace[942370503] 'compare'  (duration: 66.176954ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:34:59.038246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.141245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:34:59.0391Z","caller":"traceutil/trace.go:171","msg":"trace[521549782] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21516; }","duration":"134.055255ms","start":"2026-10-04T13:34:58.905021Z","end":"2026-10-04T13:34:59.039077Z","steps":["trace[521549782] 'agreement among raft nodes before linearized reading'  (duration: 133.119184ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:59.253381Z","caller":"traceutil/trace.go:171","msg":"trace[950943922] transaction","detail":"{read_only:false; response_revision:21517; number_of_response:1; }","duration":"185.39093ms","start":"2026-10-04T13:34:59.067958Z","end":"2026-10-04T13:34:59.253349Z","steps":["trace[950943922] 'process raft request'  (duration: 180.365043ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:34:59.253481Z","caller":"traceutil/trace.go:171","msg":"trace[421262538] linearizableReadLoop","detail":"{readStateIndex:22258; appliedIndex:22256; }","duration":"177.018871ms","start":"2026-10-04T13:34:59.076425Z","end":"2026-10-04T13:34:59.253444Z","steps":["trace[421262538] 'read index received'  (duration: 171.910821ms)","trace[421262538] 'applied index is now lower than readState.Index'  (duration: 5.10599ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:34:59.253618Z","caller":"traceutil/trace.go:171","msg":"trace[1139740107] transaction","detail":"{read_only:false; response_revision:21518; number_of_response:1; }","duration":"182.757214ms","start":"2026-10-04T13:34:59.070849Z","end":"2026-10-04T13:34:59.253607Z","steps":["trace[1139740107] 'process raft request'  (duration: 182.443487ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:34:59.25382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.394199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:34:59.253909Z","caller":"traceutil/trace.go:171","msg":"trace[679982345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21518; }","duration":"177.525531ms","start":"2026-10-04T13:34:59.076371Z","end":"2026-10-04T13:34:59.253897Z","steps":["trace[679982345] 'agreement among raft nodes before linearized reading'  (duration: 177.370897ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:35:33.648666Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19757}
{"level":"info","ts":"2026-10-04T13:35:33.771681Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19757,"took":"119.029522ms","hash":974776836,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":29167616,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-04T13:35:33.77178Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":974776836,"revision":19757,"compact-revision":17169}
{"level":"warn","ts":"2026-10-04T13:39:08.327737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.148766ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:39:08.32789Z","caller":"traceutil/trace.go:171","msg":"trace[993433687] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24055; }","duration":"266.316109ms","start":"2026-10-04T13:39:08.061554Z","end":"2026-10-04T13:39:08.32787Z","steps":["trace[993433687] 'range keys from in-memory index tree'  (duration: 265.95004ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:39:08.328206Z","caller":"traceutil/trace.go:171","msg":"trace[192471920] transaction","detail":"{read_only:false; response_revision:24056; number_of_response:1; }","duration":"146.408114ms","start":"2026-10-04T13:39:08.181763Z","end":"2026-10-04T13:39:08.328171Z","steps":["trace[192471920] 'process raft request'  (duration: 145.543465ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:39:08.329034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.030133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:39:08.329156Z","caller":"traceutil/trace.go:171","msg":"trace[1490571169] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:24055; }","duration":"202.204867ms","start":"2026-10-04T13:39:08.126916Z","end":"2026-10-04T13:39:08.329121Z","steps":["trace[1490571169] 'count revisions from in-memory index tree'  (duration: 201.91878ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:09.084118Z","caller":"traceutil/trace.go:171","msg":"trace[1441687266] transaction","detail":"{read_only:false; response_revision:24665; number_of_response:1; }","duration":"104.844124ms","start":"2026-10-04T13:40:08.979239Z","end":"2026-10-04T13:40:09.084083Z","steps":["trace[1441687266] 'process raft request'  (duration: 104.396945ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:40:20.261533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.433369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"}
{"level":"info","ts":"2026-10-04T13:40:20.261625Z","caller":"traceutil/trace.go:171","msg":"trace[851759417] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:24826; }","duration":"114.535441ms","start":"2026-10-04T13:40:20.147072Z","end":"2026-10-04T13:40:20.261607Z","steps":["trace[851759417] 'agreement among raft nodes before linearized reading'  (duration: 114.276185ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:33.656023Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21810}
{"level":"info","ts":"2026-10-04T13:40:33.776327Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21810,"took":"115.349058ms","hash":2301570322,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":43397120,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-10-04T13:40:33.776414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2301570322,"revision":21810,"compact-revision":19757}
{"level":"warn","ts":"2026-10-04T13:40:49.222699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.320527ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158035570 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25097 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:40:49.222807Z","caller":"traceutil/trace.go:171","msg":"trace[1967566038] linearizableReadLoop","detail":"{readStateIndex:25958; appliedIndex:25957; }","duration":"146.387193ms","start":"2026-10-04T13:40:49.076402Z","end":"2026-10-04T13:40:49.222789Z","steps":["trace[1967566038] 'read index received'  (duration: 30.785299ms)","trace[1967566038] 'applied index is now lower than readState.Index'  (duration: 115.600204ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:40:49.222873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.483774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:40:49.222983Z","caller":"traceutil/trace.go:171","msg":"trace[1772691013] transaction","detail":"{read_only:false; response_revision:25112; number_of_response:1; }","duration":"176.600719ms","start":"2026-10-04T13:40:49.046339Z","end":"2026-10-04T13:40:49.22294Z","steps":["trace[1772691013] 'process raft request'  (duration: 60.926854ms)","trace[1772691013] 'compare'  (duration: 115.161904ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:40:49.222895Z","caller":"traceutil/trace.go:171","msg":"trace[1518349508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25112; }","duration":"146.574717ms","start":"2026-10-04T13:40:49.076312Z","end":"2026-10-04T13:40:49.222886Z","steps":["trace[1518349508] 'agreement among raft nodes before linearized reading'  (duration: 146.520785ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:40:54.548686Z","caller":"traceutil/trace.go:171","msg":"trace[1996232311] transaction","detail":"{read_only:false; response_revision:25167; number_of_response:1; }","duration":"106.899908ms","start":"2026-10-04T13:40:54.441754Z","end":"2026-10-04T13:40:54.548654Z","steps":["trace[1996232311] 'process raft request'  (duration: 104.105468ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:29.481088Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068e7.wal"}
{"level":"info","ts":"2026-10-04T13:42:48.552868Z","caller":"traceutil/trace.go:171","msg":"trace[1796731964] linearizableReadLoop","detail":"{readStateIndex:27117; appliedIndex:27116; }","duration":"102.855173ms","start":"2026-10-04T13:42:48.449985Z","end":"2026-10-04T13:42:48.55284Z","steps":["trace[1796731964] 'read index received'  (duration: 102.76518ms)","trace[1796731964] 'applied index is now lower than readState.Index'  (duration: 88.373µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:48.552966Z","caller":"traceutil/trace.go:171","msg":"trace[517927006] transaction","detail":"{read_only:false; response_revision:26241; number_of_response:1; }","duration":"112.558832ms","start":"2026-10-04T13:42:48.440384Z","end":"2026-10-04T13:42:48.552943Z","steps":["trace[517927006] 'process raft request'  (duration: 112.233375ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:48.553153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.151389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-04T13:42:48.553215Z","caller":"traceutil/trace.go:171","msg":"trace[2104606761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26241; }","duration":"103.228161ms","start":"2026-10-04T13:42:48.449966Z","end":"2026-10-04T13:42:48.553194Z","steps":["trace[2104606761] 'agreement among raft nodes before linearized reading'  (duration: 103.028766ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:48.568479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.059775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-10-04T13:42:48.56856Z","caller":"traceutil/trace.go:171","msg":"trace[1655243477] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26243; }","duration":"102.172748ms","start":"2026-10-04T13:42:48.466347Z","end":"2026-10-04T13:42:48.56852Z","steps":["trace[1655243477] 'agreement among raft nodes before linearized reading'  (duration: 102.001335ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:54.272474Z","caller":"traceutil/trace.go:171","msg":"trace[1464951853] transaction","detail":"{read_only:false; response_revision:26285; number_of_response:1; }","duration":"142.559858ms","start":"2026-10-04T13:42:54.129889Z","end":"2026-10-04T13:42:54.272448Z","steps":["trace[1464951853] 'process raft request'  (duration: 142.384064ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:54.643475Z","caller":"traceutil/trace.go:171","msg":"trace[486080248] linearizableReadLoop","detail":"{readStateIndex:27163; appliedIndex:27161; }","duration":"467.980708ms","start":"2026-10-04T13:42:54.175464Z","end":"2026-10-04T13:42:54.643445Z","steps":["trace[486080248] 'read index received'  (duration: 96.820223ms)","trace[486080248] 'applied index is now lower than readState.Index'  (duration: 371.158885ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:54.643591Z","caller":"traceutil/trace.go:171","msg":"trace[230786043] transaction","detail":"{read_only:false; response_revision:26286; number_of_response:1; }","duration":"510.706978ms","start":"2026-10-04T13:42:54.132845Z","end":"2026-10-04T13:42:54.643552Z","steps":["trace[230786043] 'process raft request'  (duration: 510.38377ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.643736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.132836Z","time spent":"510.801659ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26270 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-04T13:42:54.643843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.321795ms","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-10-04T13:42:54.643951Z","caller":"traceutil/trace.go:171","msg":"trace[1308175278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26286; }","duration":"468.496899ms","start":"2026-10-04T13:42:54.175427Z","end":"2026-10-04T13:42:54.643924Z","steps":["trace[1308175278] 'agreement among raft nodes before linearized reading'  (duration: 468.167632ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.64399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.175408Z","time spent":"468.574311ms","remote":"127.0.0.1:36820","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":"info","ts":"2026-10-04T13:42:54.805177Z","caller":"traceutil/trace.go:171","msg":"trace[1311111543] transaction","detail":"{read_only:false; response_revision:26287; number_of_response:1; }","duration":"402.132291ms","start":"2026-10-04T13:42:54.403005Z","end":"2026-10-04T13:42:54.805137Z","steps":["trace[1311111543] 'process raft request'  (duration: 401.797104ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.805387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.402971Z","time spent":"402.308255ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:26201 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-10-04T13:42:54.80546Z","caller":"traceutil/trace.go:171","msg":"trace[156778379] transaction","detail":"{read_only:false; response_revision:26288; number_of_response:1; }","duration":"227.191608ms","start":"2026-10-04T13:42:54.578186Z","end":"2026-10-04T13:42:54.805378Z","steps":["trace[156778379] 'process raft request'  (duration: 226.831401ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:54.806045Z","caller":"traceutil/trace.go:171","msg":"trace[144990948] transaction","detail":"{read_only:false; response_revision:26289; number_of_response:1; }","duration":"205.814117ms","start":"2026-10-04T13:42:54.600179Z","end":"2026-10-04T13:42:54.805993Z","steps":["trace[144990948] 'process raft request'  (duration: 204.888457ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:54.806332Z","caller":"traceutil/trace.go:171","msg":"trace[152816451] linearizableReadLoop","detail":"{readStateIndex:27167; appliedIndex:27163; }","duration":"162.738981ms","start":"2026-10-04T13:42:54.643565Z","end":"2026-10-04T13:42:54.806304Z","steps":["trace[152816451] 'read index received'  (duration: 161.202048ms)","trace[152816451] 'applied index is now lower than readState.Index'  (duration: 1.535203ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:54.806397Z","caller":"traceutil/trace.go:171","msg":"trace[1936728522] transaction","detail":"{read_only:false; response_revision:26290; number_of_response:1; }","duration":"197.5242ms","start":"2026-10-04T13:42:54.608829Z","end":"2026-10-04T13:42:54.806354Z","steps":["trace[1936728522] 'process raft request'  (duration: 197.160032ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.806487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.726658ms","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-10-04T13:42:54.806521Z","caller":"traceutil/trace.go:171","msg":"trace[60414503] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26290; }","duration":"616.81936ms","start":"2026-10-04T13:42:54.189692Z","end":"2026-10-04T13:42:54.806511Z","steps":["trace[60414503] 'agreement among raft nodes before linearized reading'  (duration: 616.714268ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.806576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.189672Z","time spent":"616.895642ms","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-04T13:42:54.806606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.069696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-10-04T13:42:54.806659Z","caller":"traceutil/trace.go:171","msg":"trace[154690514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26290; }","duration":"201.186159ms","start":"2026-10-04T13:42:54.605458Z","end":"2026-10-04T13:42:54.806644Z","steps":["trace[154690514] 'agreement among raft nodes before linearized reading'  (duration: 200.873292ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.806771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.169524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:42:54.806819Z","caller":"traceutil/trace.go:171","msg":"trace[1997602289] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26290; }","duration":"192.251036ms","start":"2026-10-04T13:42:54.614552Z","end":"2026-10-04T13:42:54.806803Z","steps":["trace[1997602289] 'agreement among raft nodes before linearized reading'  (duration: 192.052732ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.806964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.936346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:42:54.80699Z","caller":"traceutil/trace.go:171","msg":"trace[1694107796] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:26290; }","duration":"506.963846ms","start":"2026-10-04T13:42:54.300016Z","end":"2026-10-04T13:42:54.806979Z","steps":["trace[1694107796] 'agreement among raft nodes before linearized reading'  (duration: 506.912445ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.807006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.747742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-10-04T13:42:54.807024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.299953Z","time spent":"507.060459ms","remote":"127.0.0.1:46348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":30,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "}
{"level":"info","ts":"2026-10-04T13:42:54.807043Z","caller":"traceutil/trace.go:171","msg":"trace[241094863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26290; }","duration":"202.809534ms","start":"2026-10-04T13:42:54.604223Z","end":"2026-10-04T13:42:54.807033Z","steps":["trace[241094863] 'agreement among raft nodes before linearized reading'  (duration: 202.672111ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.807133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.750359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-04T13:42:54.807179Z","caller":"traceutil/trace.go:171","msg":"trace[966129970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26290; }","duration":"458.848781ms","start":"2026-10-04T13:42:54.348316Z","end":"2026-10-04T13:42:54.807165Z","steps":["trace[966129970] 'agreement among raft nodes before linearized reading'  (duration: 458.609956ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.80721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.348297Z","time spent":"458.904403ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-10-04T13:42:54.807328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.662258ms","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-10-04T13:42:54.807365Z","caller":"traceutil/trace.go:171","msg":"trace[117054222] 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:26290; }","duration":"451.749369ms","start":"2026-10-04T13:42:54.355603Z","end":"2026-10-04T13:42:54.807353Z","steps":["trace[117054222] 'agreement among raft nodes before linearized reading'  (duration: 451.687737ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:54.807392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:42:54.355558Z","time spent":"451.82622ms","remote":"127.0.0.1:46680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"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-10-04T13:42:54.809815Z","caller":"traceutil/trace.go:171","msg":"trace[2030539483] transaction","detail":"{read_only:false; response_revision:26291; number_of_response:1; }","duration":"159.345778ms","start":"2026-10-04T13:42:54.650451Z","end":"2026-10-04T13:42:54.809797Z","steps":["trace[2030539483] 'process raft request'  (duration: 159.218895ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:59.160811Z","caller":"traceutil/trace.go:171","msg":"trace[1014933694] transaction","detail":"{read_only:false; response_revision:26327; number_of_response:1; }","duration":"193.35817ms","start":"2026-10-04T13:42:58.967406Z","end":"2026-10-04T13:42:59.160764Z","steps":["trace[1014933694] 'process raft request'  (duration: 120.808678ms)","trace[1014933694] 'compare'  (duration: 71.461778ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:42:59.467218Z","caller":"traceutil/trace.go:171","msg":"trace[140029615] transaction","detail":"{read_only:false; response_revision:26328; number_of_response:1; }","duration":"140.176266ms","start":"2026-10-04T13:42:59.327016Z","end":"2026-10-04T13:42:59.467192Z","steps":["trace[140029615] 'process raft request'  (duration: 139.976432ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:42:59.476705Z","caller":"traceutil/trace.go:171","msg":"trace[101209126] transaction","detail":"{read_only:false; response_revision:26329; number_of_response:1; }","duration":"143.536398ms","start":"2026-10-04T13:42:59.333138Z","end":"2026-10-04T13:42:59.476674Z","steps":["trace[101209126] 'process raft request'  (duration: 143.318144ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:42:59.972195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.309824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:42:59.972321Z","caller":"traceutil/trace.go:171","msg":"trace[519155515] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26330; }","duration":"104.547699ms","start":"2026-10-04T13:42:59.867756Z","end":"2026-10-04T13:42:59.972304Z","steps":["trace[519155515] 'count revisions from in-memory index tree'  (duration: 104.180231ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.142511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.767124ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158038620 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26319 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:43:01.142659Z","caller":"traceutil/trace.go:171","msg":"trace[1230744515] transaction","detail":"{read_only:false; response_revision:26333; number_of_response:1; }","duration":"410.739537ms","start":"2026-10-04T13:43:00.731894Z","end":"2026-10-04T13:43:01.142634Z","steps":["trace[1230744515] 'process raft request'  (duration: 199.744387ms)","trace[1230744515] 'compare'  (duration: 210.642542ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:01.142736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.73187Z","time spent":"410.839279ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26319 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:01.592295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.816179ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158038621 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26320 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:43:01.592598Z","caller":"traceutil/trace.go:171","msg":"trace[1374089278] transaction","detail":"{read_only:false; response_revision:26336; number_of_response:1; }","duration":"424.476643ms","start":"2026-10-04T13:43:01.168096Z","end":"2026-10-04T13:43:01.592573Z","steps":["trace[1374089278] 'process raft request'  (duration: 424.399421ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:01.592623Z","caller":"traceutil/trace.go:171","msg":"trace[1411085566] transaction","detail":"{read_only:false; response_revision:26334; number_of_response:1; }","duration":"762.878323ms","start":"2026-10-04T13:43:00.829707Z","end":"2026-10-04T13:43:01.592585Z","steps":["trace[1411085566] 'process raft request'  (duration: 509.761227ms)","trace[1411085566] 'compare'  (duration: 252.536763ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:01.592675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:01.168056Z","time spent":"424.580425ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26327 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-04T13:43:01.592667Z","caller":"traceutil/trace.go:171","msg":"trace[913147662] linearizableReadLoop","detail":"{readStateIndex:27213; appliedIndex:27210; }","duration":"752.09509ms","start":"2026-10-04T13:43:00.840548Z","end":"2026-10-04T13:43:01.592643Z","steps":["trace[913147662] 'read index received'  (duration: 91.11742ms)","trace[913147662] 'applied index is now lower than readState.Index'  (duration: 660.97367ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:01.592668Z","caller":"traceutil/trace.go:171","msg":"trace[2132299599] transaction","detail":"{read_only:false; response_revision:26335; number_of_response:1; }","duration":"761.343391ms","start":"2026-10-04T13:43:00.83127Z","end":"2026-10-04T13:43:01.592614Z","steps":["trace[2132299599] 'process raft request'  (duration: 761.142846ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.592804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.829675Z","time spent":"763.022276ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26320 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:01.592925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.377507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T13:43:01.592924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.831257Z","time spent":"761.516114ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26321 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-04T13:43:01.592967Z","caller":"traceutil/trace.go:171","msg":"trace[1895289129] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26336; }","duration":"752.450278ms","start":"2026-10-04T13:43:00.840504Z","end":"2026-10-04T13:43:01.592954Z","steps":["trace[1895289129] 'agreement among raft nodes before linearized reading'  (duration: 752.260484ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.593024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.840497Z","time spent":"752.496569ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-10-04T13:43:01.605068Z","caller":"traceutil/trace.go:171","msg":"trace[223987421] transaction","detail":"{read_only:false; response_revision:26337; number_of_response:1; }","duration":"129.805082ms","start":"2026-10-04T13:43:01.475243Z","end":"2026-10-04T13:43:01.605048Z","steps":["trace[223987421] 'process raft request'  (duration: 129.641098ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.975383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.462058ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158038625 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26329 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:43:01.975666Z","caller":"traceutil/trace.go:171","msg":"trace[352954322] linearizableReadLoop","detail":"{readStateIndex:27216; appliedIndex:27214; }","duration":"382.925788ms","start":"2026-10-04T13:43:01.59272Z","end":"2026-10-04T13:43:01.975646Z","steps":["trace[352954322] 'read index received'  (duration: 12.213983ms)","trace[352954322] 'applied index is now lower than readState.Index'  (duration: 370.710085ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:01.975858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126341422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:43:01.975913Z","caller":"traceutil/trace.go:171","msg":"trace[1598216018] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26339; }","duration":"1.126463144s","start":"2026-10-04T13:43:00.849438Z","end":"2026-10-04T13:43:01.975901Z","steps":["trace[1598216018] 'agreement among raft nodes before linearized reading'  (duration: 1.12626012s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.976127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.849348Z","time spent":"1.126770131s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-04T13:43:01.976161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.250446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:01.976237Z","caller":"traceutil/trace.go:171","msg":"trace[1670946137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26339; }","duration":"899.38267ms","start":"2026-10-04T13:43:01.076835Z","end":"2026-10-04T13:43:01.976217Z","steps":["trace[1670946137] 'agreement among raft nodes before linearized reading'  (duration: 899.043512ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.976276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:01.07681Z","time spent":"899.459011ms","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-04T13:43:01.976257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.887845ms","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-10-04T13:43:01.976301Z","caller":"traceutil/trace.go:171","msg":"trace[334516499] transaction","detail":"{read_only:false; response_revision:26339; number_of_response:1; }","duration":"377.723477ms","start":"2026-10-04T13:43:01.598509Z","end":"2026-10-04T13:43:01.976233Z","steps":["trace[334516499] 'process raft request'  (duration: 376.986921ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:01.976301Z","caller":"traceutil/trace.go:171","msg":"trace[833248606] transaction","detail":"{read_only:false; response_revision:26338; number_of_response:1; }","duration":"493.096047ms","start":"2026-10-04T13:43:01.483151Z","end":"2026-10-04T13:43:01.976247Z","steps":["trace[833248606] 'process raft request'  (duration: 380.664959ms)","trace[833248606] 'compare'  (duration: 110.859485ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:01.976353Z","caller":"traceutil/trace.go:171","msg":"trace[1015433651] 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:26339; }","duration":"949.061649ms","start":"2026-10-04T13:43:01.027266Z","end":"2026-10-04T13:43:01.976328Z","steps":["trace[1015433651] 'agreement among raft nodes before linearized reading'  (duration: 948.877095ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.976409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:01.027238Z","time spent":"949.16103ms","remote":"127.0.0.1:46788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-10-04T13:43:01.976413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116359397s","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-10-04T13:43:01.976474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:01.598482Z","time spent":"377.88359ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:26322 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:01.976489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117592144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-10-04T13:43:01.976506Z","caller":"traceutil/trace.go:171","msg":"trace[1761499653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26339; }","duration":"1.116527231s","start":"2026-10-04T13:43:00.859957Z","end":"2026-10-04T13:43:01.976484Z","steps":["trace[1761499653] 'agreement among raft nodes before linearized reading'  (duration: 1.116180234s)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:01.976553Z","caller":"traceutil/trace.go:171","msg":"trace[514184108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26339; }","duration":"1.117669535s","start":"2026-10-04T13:43:00.858849Z","end":"2026-10-04T13:43:01.976519Z","steps":["trace[514184108] 'agreement among raft nodes before linearized reading'  (duration: 1.117301818s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.976583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.858838Z","time spent":"1.117737737s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-10-04T13:43:01.976569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:01.483112Z","time spent":"493.296283ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26329 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:01.976584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.859931Z","time spent":"1.116641753s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-10-04T13:43:01.976676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.122838877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-04T13:43:01.976749Z","caller":"traceutil/trace.go:171","msg":"trace[1300874385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26339; }","duration":"1.123086302s","start":"2026-10-04T13:43:00.853631Z","end":"2026-10-04T13:43:01.976717Z","steps":["trace[1300874385] 'agreement among raft nodes before linearized reading'  (duration: 1.122550281s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:01.976783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:00.853619Z","time spent":"1.123154323s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-10-04T13:43:01.97882Z","caller":"traceutil/trace.go:171","msg":"trace[51989993] transaction","detail":"{read_only:false; response_revision:26340; number_of_response:1; }","duration":"195.357683ms","start":"2026-10-04T13:43:01.783421Z","end":"2026-10-04T13:43:01.978778Z","steps":["trace[51989993] 'process raft request'  (duration: 194.918132ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:02.156587Z","caller":"traceutil/trace.go:171","msg":"trace[1108693240] transaction","detail":"{read_only:false; response_revision:26344; number_of_response:1; }","duration":"170.293514ms","start":"2026-10-04T13:43:01.986236Z","end":"2026-10-04T13:43:02.156529Z","steps":["trace[1108693240] 'process raft request'  (duration: 170.247442ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:02.156668Z","caller":"traceutil/trace.go:171","msg":"trace[1840054707] linearizableReadLoop","detail":"{readStateIndex:27219; appliedIndex:27218; }","duration":"172.939491ms","start":"2026-10-04T13:43:01.983649Z","end":"2026-10-04T13:43:02.156588Z","steps":["trace[1840054707] 'read index received'  (duration: 110.238281ms)","trace[1840054707] 'applied index is now lower than readState.Index'  (duration: 62.69535ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:02.156887Z","caller":"traceutil/trace.go:171","msg":"trace[1329702569] transaction","detail":"{read_only:false; response_revision:26342; number_of_response:1; }","duration":"173.128625ms","start":"2026-10-04T13:43:01.983745Z","end":"2026-10-04T13:43:02.156874Z","steps":["trace[1329702569] 'process raft request'  (duration: 172.654414ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:02.15693Z","caller":"traceutil/trace.go:171","msg":"trace[967144206] transaction","detail":"{read_only:false; response_revision:26343; number_of_response:1; }","duration":"171.192003ms","start":"2026-10-04T13:43:01.985702Z","end":"2026-10-04T13:43:02.156894Z","steps":["trace[967144206] 'process raft request'  (duration: 170.744063ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:02.156946Z","caller":"traceutil/trace.go:171","msg":"trace[175898695] transaction","detail":"{read_only:false; response_revision:26341; number_of_response:1; }","duration":"173.402071ms","start":"2026-10-04T13:43:01.983481Z","end":"2026-10-04T13:43:02.156883Z","steps":["trace[175898695] 'process raft request'  (duration: 110.370795ms)","trace[175898695] 'compare'  (duration: 62.365852ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:02.15711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.1188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:02.157157Z","caller":"traceutil/trace.go:171","msg":"trace[1253293124] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:26344; }","duration":"163.233691ms","start":"2026-10-04T13:43:01.993904Z","end":"2026-10-04T13:43:02.157138Z","steps":["trace[1253293124] 'agreement among raft nodes before linearized reading'  (duration: 163.13755ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:02.157671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.987173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:02.157743Z","caller":"traceutil/trace.go:171","msg":"trace[1479284638] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26344; }","duration":"174.109295ms","start":"2026-10-04T13:43:01.983617Z","end":"2026-10-04T13:43:02.157726Z","steps":["trace[1479284638] 'agreement among raft nodes before linearized reading'  (duration: 173.965962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:02.586292Z","caller":"traceutil/trace.go:171","msg":"trace[328674364] transaction","detail":"{read_only:false; response_revision:26345; number_of_response:1; }","duration":"206.311038ms","start":"2026-10-04T13:43:02.379939Z","end":"2026-10-04T13:43:02.58625Z","steps":["trace[328674364] 'process raft request'  (duration: 206.048763ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:02.966108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.474399ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158038641 > lease_revoke:<id:601ba106f74e8169>","response":"size:30"}
{"level":"info","ts":"2026-10-04T13:43:02.966238Z","caller":"traceutil/trace.go:171","msg":"trace[794937403] linearizableReadLoop","detail":"{readStateIndex:27224; appliedIndex:27223; }","duration":"334.20224ms","start":"2026-10-04T13:43:02.632013Z","end":"2026-10-04T13:43:02.966216Z","steps":["trace[794937403] 'read index received'  (duration: 43.593198ms)","trace[794937403] 'applied index is now lower than readState.Index'  (duration: 290.607232ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:02.96718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.151361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-10-04T13:43:02.967218Z","caller":"traceutil/trace.go:171","msg":"trace[284639401] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:26345; }","duration":"335.241683ms","start":"2026-10-04T13:43:02.631963Z","end":"2026-10-04T13:43:02.967204Z","steps":["trace[284639401] 'agreement among raft nodes before linearized reading'  (duration: 335.058298ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:02.967255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:02.631942Z","time spent":"335.304594ms","remote":"127.0.0.1:36706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":1590,"request content":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" "}
{"level":"info","ts":"2026-10-04T13:43:03.357067Z","caller":"traceutil/trace.go:171","msg":"trace[309624752] linearizableReadLoop","detail":"{readStateIndex:27225; appliedIndex:27224; }","duration":"187.056014ms","start":"2026-10-04T13:43:03.169977Z","end":"2026-10-04T13:43:03.357033Z","steps":["trace[309624752] 'read index received'  (duration: 186.790888ms)","trace[309624752] 'applied index is now lower than readState.Index'  (duration: 263.706µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:03.357137Z","caller":"traceutil/trace.go:171","msg":"trace[389599206] transaction","detail":"{read_only:false; response_revision:26346; number_of_response:1; }","duration":"190.851816ms","start":"2026-10-04T13:43:03.166235Z","end":"2026-10-04T13:43:03.357087Z","steps":["trace[389599206] 'process raft request'  (duration: 190.516498ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:03.357294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.283449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:03.357431Z","caller":"traceutil/trace.go:171","msg":"trace[1868200027] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:26346; }","duration":"187.469453ms","start":"2026-10-04T13:43:03.169927Z","end":"2026-10-04T13:43:03.357397Z","steps":["trace[1868200027] 'agreement among raft nodes before linearized reading'  (duration: 187.232088ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.00289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.821308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:43:04.002981Z","caller":"traceutil/trace.go:171","msg":"trace[1665919248] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:26346; }","duration":"549.969352ms","start":"2026-10-04T13:43:03.452989Z","end":"2026-10-04T13:43:04.002958Z","steps":["trace[1665919248] 'count revisions from in-memory index tree'  (duration: 549.710396ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.003024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:03.452964Z","time spent":"550.046904ms","remote":"127.0.0.1:36920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":32,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"info","ts":"2026-10-04T13:43:04.003613Z","caller":"traceutil/trace.go:171","msg":"trace[868937597] transaction","detail":"{read_only:false; response_revision:26347; number_of_response:1; }","duration":"404.200226ms","start":"2026-10-04T13:43:03.599398Z","end":"2026-10-04T13:43:04.003598Z","steps":["trace[868937597] 'process raft request'  (duration: 377.648645ms)","trace[868937597] 'compare'  (duration: 25.241424ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:04.003724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:03.59937Z","time spent":"404.285589ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26336 > 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":"info","ts":"2026-10-04T13:43:04.179213Z","caller":"traceutil/trace.go:171","msg":"trace[1028767745] transaction","detail":"{read_only:false; response_revision:26349; number_of_response:1; }","duration":"579.330704ms","start":"2026-10-04T13:43:03.599853Z","end":"2026-10-04T13:43:04.179183Z","steps":["trace[1028767745] 'process raft request'  (duration: 579.202431ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.179406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:03.59982Z","time spent":"579.477407ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26334 > 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-10-04T13:43:04.179674Z","caller":"traceutil/trace.go:171","msg":"trace[1159331824] transaction","detail":"{read_only:false; response_revision:26348; number_of_response:1; }","duration":"579.806975ms","start":"2026-10-04T13:43:03.59982Z","end":"2026-10-04T13:43:04.179627Z","steps":["trace[1159331824] 'process raft request'  (duration: 579.037888ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:04.179717Z","caller":"traceutil/trace.go:171","msg":"trace[1257625405] transaction","detail":"{read_only:false; response_revision:26350; number_of_response:1; }","duration":"576.002901ms","start":"2026-10-04T13:43:03.603684Z","end":"2026-10-04T13:43:04.179687Z","steps":["trace[1257625405] 'process raft request'  (duration: 575.425809ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.179883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:03.599788Z","time spent":"579.981577ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26335 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-04T13:43:04.179955Z","caller":"traceutil/trace.go:171","msg":"trace[737846005] linearizableReadLoop","detail":"{readStateIndex:27230; appliedIndex:27226; }","duration":"194.432942ms","start":"2026-10-04T13:43:03.985504Z","end":"2026-10-04T13:43:04.179937Z","steps":["trace[737846005] 'read index received'  (duration: 193.470681ms)","trace[737846005] 'applied index is now lower than readState.Index'  (duration: 960.841µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:04.180078Z","caller":"traceutil/trace.go:171","msg":"trace[1387980843] transaction","detail":"{read_only:false; response_revision:26351; number_of_response:1; }","duration":"569.39793ms","start":"2026-10-04T13:43:03.610663Z","end":"2026-10-04T13:43:04.180061Z","steps":["trace[1387980843] 'process raft request'  (duration: 568.907569ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.18012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:03.603669Z","time spent":"576.178346ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:26318 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:04.180139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:03.610645Z","time spent":"569.460342ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26337 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:04.180254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.75188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:43:04.18032Z","caller":"traceutil/trace.go:171","msg":"trace[1340858225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26351; }","duration":"194.858012ms","start":"2026-10-04T13:43:03.985443Z","end":"2026-10-04T13:43:04.180301Z","steps":["trace[1340858225] 'agreement among raft nodes before linearized reading'  (duration: 194.687418ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:04.192839Z","caller":"traceutil/trace.go:171","msg":"trace[211121074] transaction","detail":"{read_only:false; response_revision:26352; number_of_response:1; }","duration":"204.378717ms","start":"2026-10-04T13:43:03.988432Z","end":"2026-10-04T13:43:04.19281Z","steps":["trace[211121074] 'process raft request'  (duration: 204.152062ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:04.1932Z","caller":"traceutil/trace.go:171","msg":"trace[1233293497] transaction","detail":"{read_only:false; response_revision:26353; number_of_response:1; }","duration":"204.702974ms","start":"2026-10-04T13:43:03.988477Z","end":"2026-10-04T13:43:04.19318Z","steps":["trace[1233293497] 'process raft request'  (duration: 204.274024ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:04.501776Z","caller":"traceutil/trace.go:171","msg":"trace[218563274] transaction","detail":"{read_only:false; response_revision:26355; number_of_response:1; }","duration":"303.115821ms","start":"2026-10-04T13:43:04.198621Z","end":"2026-10-04T13:43:04.501737Z","steps":["trace[218563274] 'process raft request'  (duration: 302.632621ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.502008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:04.198596Z","time spent":"303.284906ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26342 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-04T13:43:04.502169Z","caller":"traceutil/trace.go:171","msg":"trace[1948365624] transaction","detail":"{read_only:false; response_revision:26356; number_of_response:1; }","duration":"302.63625ms","start":"2026-10-04T13:43:04.19946Z","end":"2026-10-04T13:43:04.502096Z","steps":["trace[1948365624] 'process raft request'  (duration: 302.20648ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:04.502187Z","caller":"traceutil/trace.go:171","msg":"trace[532004050] transaction","detail":"{read_only:false; response_revision:26358; number_of_response:1; }","duration":"302.12916ms","start":"2026-10-04T13:43:04.200027Z","end":"2026-10-04T13:43:04.502156Z","steps":["trace[532004050] 'process raft request'  (duration: 302.07483ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:04.50227Z","caller":"traceutil/trace.go:171","msg":"trace[1240842965] transaction","detail":"{read_only:false; response_revision:26357; number_of_response:1; }","duration":"302.594879ms","start":"2026-10-04T13:43:04.19962Z","end":"2026-10-04T13:43:04.502215Z","steps":["trace[1240842965] 'process raft request'  (duration: 302.324693ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:04.502387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:04.200012Z","time spent":"302.268483ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26344 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:04.502646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:04.199586Z","time spent":"302.911307ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26343 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:04.502395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:04.199447Z","time spent":"302.826015ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26341 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T13:43:04.724416Z","caller":"traceutil/trace.go:171","msg":"trace[945196039] transaction","detail":"{read_only:false; response_revision:26359; number_of_response:1; }","duration":"131.421758ms","start":"2026-10-04T13:43:04.592947Z","end":"2026-10-04T13:43:04.724369Z","steps":["trace[945196039] 'process raft request'  (duration: 112.889639ms)","trace[945196039] 'compare'  (duration: 18.206662ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:05.067873Z","caller":"traceutil/trace.go:171","msg":"trace[575794642] transaction","detail":"{read_only:false; response_revision:26360; number_of_response:1; }","duration":"161.596457ms","start":"2026-10-04T13:43:04.906248Z","end":"2026-10-04T13:43:05.067844Z","steps":["trace[575794642] 'process raft request'  (duration: 154.79375ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:05.433475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.724098ms","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-10-04T13:43:05.433605Z","caller":"traceutil/trace.go:171","msg":"trace[975198158] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26360; }","duration":"259.903022ms","start":"2026-10-04T13:43:05.173676Z","end":"2026-10-04T13:43:05.433579Z","steps":["trace[975198158] 'range keys from in-memory index tree'  (duration: 259.483963ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:05.433718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.073883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:05.43379Z","caller":"traceutil/trace.go:171","msg":"trace[634456511] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:26360; }","duration":"120.206276ms","start":"2026-10-04T13:43:05.313565Z","end":"2026-10-04T13:43:05.433772Z","steps":["trace[634456511] 'count revisions from in-memory index tree'  (duration: 119.90954ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:05.748511Z","caller":"traceutil/trace.go:171","msg":"trace[812094362] linearizableReadLoop","detail":"{readStateIndex:27240; appliedIndex:27239; }","duration":"235.18193ms","start":"2026-10-04T13:43:05.513296Z","end":"2026-10-04T13:43:05.748478Z","steps":["trace[812094362] 'read index received'  (duration: 234.7202ms)","trace[812094362] 'applied index is now lower than readState.Index'  (duration: 460.36µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:05.748717Z","caller":"traceutil/trace.go:171","msg":"trace[1817371206] transaction","detail":"{read_only:false; response_revision:26361; number_of_response:1; }","duration":"308.951517ms","start":"2026-10-04T13:43:05.439748Z","end":"2026-10-04T13:43:05.748699Z","steps":["trace[1817371206] 'process raft request'  (duration: 308.391476ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:05.748887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:05.439729Z","time spent":"309.033349ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26346 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:05.749032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.713721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:05.749109Z","caller":"traceutil/trace.go:171","msg":"trace[1025851396] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26361; }","duration":"235.852083ms","start":"2026-10-04T13:43:05.513238Z","end":"2026-10-04T13:43:05.74909Z","steps":["trace[1025851396] 'agreement among raft nodes before linearized reading'  (duration: 235.737971ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:06.142072Z","caller":"traceutil/trace.go:171","msg":"trace[920837791] transaction","detail":"{read_only:false; response_revision:26362; number_of_response:1; }","duration":"131.788925ms","start":"2026-10-04T13:43:06.010256Z","end":"2026-10-04T13:43:06.142045Z","steps":["trace[920837791] 'process raft request'  (duration: 131.54904ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:06.477063Z","caller":"traceutil/trace.go:171","msg":"trace[1855167700] transaction","detail":"{read_only:false; response_revision:26363; number_of_response:1; }","duration":"289.928389ms","start":"2026-10-04T13:43:06.187092Z","end":"2026-10-04T13:43:06.47702Z","steps":["trace[1855167700] 'process raft request'  (duration: 206.940494ms)","trace[1855167700] 'compare'  (duration: 82.470283ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:06.527906Z","caller":"traceutil/trace.go:171","msg":"trace[896934692] transaction","detail":"{read_only:false; response_revision:26364; number_of_response:1; }","duration":"340.728051ms","start":"2026-10-04T13:43:06.187152Z","end":"2026-10-04T13:43:06.52788Z","steps":["trace[896934692] 'process raft request'  (duration: 340.495066ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:06.528096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:06.187106Z","time spent":"340.890164ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26351 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-04T13:43:06.528343Z","caller":"traceutil/trace.go:171","msg":"trace[988955754] transaction","detail":"{read_only:false; response_revision:26366; number_of_response:1; }","duration":"328.412776ms","start":"2026-10-04T13:43:06.199916Z","end":"2026-10-04T13:43:06.528329Z","steps":["trace[988955754] 'process raft request'  (duration: 328.185871ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:06.52834Z","caller":"traceutil/trace.go:171","msg":"trace[103003568] linearizableReadLoop","detail":"{readStateIndex:27246; appliedIndex:27241; }","duration":"287.24949ms","start":"2026-10-04T13:43:06.241058Z","end":"2026-10-04T13:43:06.528308Z","steps":["trace[103003568] 'read index received'  (duration: 153.059863ms)","trace[103003568] 'applied index is now lower than readState.Index'  (duration: 134.188337ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:06.528411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:06.199885Z","time spent":"328.478616ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26352 > 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-10-04T13:43:06.528389Z","caller":"traceutil/trace.go:171","msg":"trace[144989338] transaction","detail":"{read_only:false; response_revision:26365; number_of_response:1; }","duration":"339.731479ms","start":"2026-10-04T13:43:06.188617Z","end":"2026-10-04T13:43:06.528349Z","steps":["trace[144989338] 'process raft request'  (duration: 339.194297ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:06.528444Z","caller":"traceutil/trace.go:171","msg":"trace[1648923890] transaction","detail":"{read_only:false; response_revision:26367; number_of_response:1; }","duration":"328.15668ms","start":"2026-10-04T13:43:06.20025Z","end":"2026-10-04T13:43:06.528406Z","steps":["trace[1648923890] 'process raft request'  (duration: 327.988716ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:06.528585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:06.18859Z","time spent":"339.884552ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26348 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:06.528635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:06.200235Z","time spent":"328.282132ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26353 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:06.528743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.669019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:43:06.528794Z","caller":"traceutil/trace.go:171","msg":"trace[1018282595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26367; }","duration":"287.821722ms","start":"2026-10-04T13:43:06.240955Z","end":"2026-10-04T13:43:06.528777Z","steps":["trace[1018282595] 'agreement among raft nodes before linearized reading'  (duration: 287.518345ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:15.878531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.527571ms","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-10-04T13:43:15.878829Z","caller":"traceutil/trace.go:171","msg":"trace[1888703636] 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:26433; }","duration":"493.902998ms","start":"2026-10-04T13:43:15.384902Z","end":"2026-10-04T13:43:15.878805Z","steps":["trace[1888703636] 'count revisions from in-memory index tree'  (duration: 493.395558ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:15.878877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:15.384872Z","time spent":"493.99089ms","remote":"127.0.0.1:46788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"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-10-04T13:43:15.878906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.605319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"}
{"level":"info","ts":"2026-10-04T13:43:15.879004Z","caller":"traceutil/trace.go:171","msg":"trace[482183920] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:26433; }","duration":"229.768732ms","start":"2026-10-04T13:43:15.649211Z","end":"2026-10-04T13:43:15.87898Z","steps":["trace[482183920] 'range keys from in-memory index tree'  (duration: 229.395754ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:16.035255Z","caller":"traceutil/trace.go:171","msg":"trace[1452036526] linearizableReadLoop","detail":"{readStateIndex:27315; appliedIndex:27314; }","duration":"233.92071ms","start":"2026-10-04T13:43:15.801301Z","end":"2026-10-04T13:43:16.035222Z","steps":["trace[1452036526] 'read index received'  (duration: 233.705195ms)","trace[1452036526] 'applied index is now lower than readState.Index'  (duration: 214.085µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:16.035384Z","caller":"traceutil/trace.go:171","msg":"trace[1456256773] transaction","detail":"{read_only:false; response_revision:26434; number_of_response:1; }","duration":"291.756987ms","start":"2026-10-04T13:43:15.743585Z","end":"2026-10-04T13:43:16.035342Z","steps":["trace[1456256773] 'process raft request'  (duration: 291.45303ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:16.035658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.691953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0f1593bf-3ab6-47b8-bcd8-280a22fe62d0\" ","response":"range_response_count:1 size:1294"}
{"level":"info","ts":"2026-10-04T13:43:16.036316Z","caller":"traceutil/trace.go:171","msg":"trace[804620773] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0f1593bf-3ab6-47b8-bcd8-280a22fe62d0; range_end:; response_count:1; response_revision:26434; }","duration":"152.349456ms","start":"2026-10-04T13:43:15.883942Z","end":"2026-10-04T13:43:16.036292Z","steps":["trace[804620773] 'agreement among raft nodes before linearized reading'  (duration: 151.56578ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:16.035686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.337688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:43:16.036851Z","caller":"traceutil/trace.go:171","msg":"trace[1324831518] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26434; }","duration":"235.602236ms","start":"2026-10-04T13:43:15.801234Z","end":"2026-10-04T13:43:16.036836Z","steps":["trace[1324831518] 'agreement among raft nodes before linearized reading'  (duration: 234.162335ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:16.035683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.646008ms","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-10-04T13:43:16.036988Z","caller":"traceutil/trace.go:171","msg":"trace[1410640776] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26434; }","duration":"142.995477ms","start":"2026-10-04T13:43:15.893955Z","end":"2026-10-04T13:43:16.036951Z","steps":["trace[1410640776] 'agreement among raft nodes before linearized reading'  (duration: 141.580477ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:16.280308Z","caller":"traceutil/trace.go:171","msg":"trace[1208035152] linearizableReadLoop","detail":"{readStateIndex:27316; appliedIndex:27315; }","duration":"238.187222ms","start":"2026-10-04T13:43:16.042088Z","end":"2026-10-04T13:43:16.280275Z","steps":["trace[1208035152] 'read index received'  (duration: 214.671499ms)","trace[1208035152] 'applied index is now lower than readState.Index'  (duration: 23.514293ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:16.280491Z","caller":"traceutil/trace.go:171","msg":"trace[195014018] transaction","detail":"{read_only:false; response_revision:26435; number_of_response:1; }","duration":"238.942678ms","start":"2026-10-04T13:43:16.041512Z","end":"2026-10-04T13:43:16.280455Z","steps":["trace[195014018] 'process raft request'  (duration: 215.323702ms)","trace[195014018] 'compare'  (duration: 23.260408ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:16.280666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.550589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0\" ","response":"range_response_count:1 size:1566"}
{"level":"info","ts":"2026-10-04T13:43:16.280751Z","caller":"traceutil/trace.go:171","msg":"trace[40342052] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-sb-0; range_end:; response_count:1; response_revision:26435; }","duration":"238.696713ms","start":"2026-10-04T13:43:16.042038Z","end":"2026-10-04T13:43:16.280735Z","steps":["trace[40342052] 'agreement among raft nodes before linearized reading'  (duration: 238.407466ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:16.78087Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16148677940158038839,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-10-04T13:43:17.323107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.893448ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158038838 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26420 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:43:17.323227Z","caller":"traceutil/trace.go:171","msg":"trace[2053385103] transaction","detail":"{read_only:false; response_revision:26436; number_of_response:1; }","duration":"1.125570421s","start":"2026-10-04T13:43:16.197633Z","end":"2026-10-04T13:43:17.323204Z","steps":["trace[2053385103] 'process raft request'  (duration: 711.47614ms)","trace[2053385103] 'compare'  (duration: 413.669382ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:17.324199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.1976Z","time spent":"1.126555933s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:26420 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:18.001827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.515376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158038840 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26422 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:43:18.002363Z","caller":"traceutil/trace.go:171","msg":"trace[1607178975] transaction","detail":"{read_only:false; response_revision:26440; number_of_response:1; }","duration":"1.415614781s","start":"2026-10-04T13:43:16.586717Z","end":"2026-10-04T13:43:18.002331Z","steps":["trace[1607178975] 'process raft request'  (duration: 1.415487528s)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:18.002414Z","caller":"traceutil/trace.go:171","msg":"trace[1120413429] transaction","detail":"{read_only:false; response_revision:26438; number_of_response:1; }","duration":"1.424791989s","start":"2026-10-04T13:43:16.577585Z","end":"2026-10-04T13:43:18.002377Z","steps":["trace[1120413429] 'process raft request'  (duration: 1.42441137s)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:18.002437Z","caller":"traceutil/trace.go:171","msg":"trace[601838476] transaction","detail":"{read_only:false; response_revision:26439; number_of_response:1; }","duration":"1.421998897s","start":"2026-10-04T13:43:16.580391Z","end":"2026-10-04T13:43:18.00239Z","steps":["trace[601838476] 'process raft request'  (duration: 1.421761112s)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:18.002887Z","caller":"traceutil/trace.go:171","msg":"trace[481596167] linearizableReadLoop","detail":"{readStateIndex:27322; appliedIndex:27316; }","duration":"1.722478701s","start":"2026-10-04T13:43:16.280377Z","end":"2026-10-04T13:43:18.002855Z","steps":["trace[481596167] 'read index received'  (duration: 628.633108ms)","trace[481596167] 'applied index is now lower than readState.Index'  (duration: 1.093844063s)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:18.002969Z","caller":"traceutil/trace.go:171","msg":"trace[986785429] transaction","detail":"{read_only:false; response_revision:26442; number_of_response:1; }","duration":"1.21485044s","start":"2026-10-04T13:43:16.788097Z","end":"2026-10-04T13:43:18.002947Z","steps":["trace[986785429] 'process raft request'  (duration: 1.214403501s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.788069Z","time spent":"1.214963462s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26432 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:18.003159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.960614742s","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-10-04T13:43:18.003201Z","caller":"traceutil/trace.go:171","msg":"trace[344893928] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26442; }","duration":"1.960731924s","start":"2026-10-04T13:43:16.042455Z","end":"2026-10-04T13:43:18.003187Z","steps":["trace[344893928] 'agreement among raft nodes before linearized reading'  (duration: 1.960586742s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.042441Z","time spent":"1.960784836s","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-04T13:43:18.00323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.718882555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1e58c41b-58a2-4ab3-8189-faef715a6353\" ","response":"range_response_count:1 size:1284"}
{"level":"info","ts":"2026-10-04T13:43:18.003307Z","caller":"traceutil/trace.go:171","msg":"trace[287926157] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1e58c41b-58a2-4ab3-8189-faef715a6353; range_end:; response_count:1; response_revision:26442; }","duration":"1.719001807s","start":"2026-10-04T13:43:16.284286Z","end":"2026-10-04T13:43:18.003288Z","steps":["trace[287926157] 'agreement among raft nodes before linearized reading'  (duration: 1.718801872s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.284262Z","time spent":"1.719078568s","remote":"127.0.0.1:36702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1308,"request content":"key:\"/registry/persistentvolumes/pvc-1e58c41b-58a2-4ab3-8189-faef715a6353\" "}
{"level":"warn","ts":"2026-10-04T13:43:18.003478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.389625107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-10-04T13:43:18.002928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.580358Z","time spent":"1.422463078s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26424 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-04T13:43:18.003569Z","caller":"traceutil/trace.go:171","msg":"trace[1180137024] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26442; }","duration":"1.389691188s","start":"2026-10-04T13:43:16.613839Z","end":"2026-10-04T13:43:18.00353Z","steps":["trace[1180137024] 'agreement among raft nodes before linearized reading'  (duration: 1.389486933s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.613795Z","time spent":"1.38980761s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-04T13:43:18.003714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.407404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T13:43:18.003728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398079318s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-10-04T13:43:18.003734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.887764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:18.003775Z","caller":"traceutil/trace.go:171","msg":"trace[229372228] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:26442; }","duration":"817.528127ms","start":"2026-10-04T13:43:17.186227Z","end":"2026-10-04T13:43:18.003756Z","steps":["trace[229372228] 'agreement among raft nodes before linearized reading'  (duration: 817.407474ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:18.003775Z","caller":"traceutil/trace.go:171","msg":"trace[1492415670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26442; }","duration":"1.398178149s","start":"2026-10-04T13:43:16.605582Z","end":"2026-10-04T13:43:18.00376Z","steps":["trace[1492415670] 'agreement among raft nodes before linearized reading'  (duration: 1.398066696s)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:18.003792Z","caller":"traceutil/trace.go:171","msg":"trace[206720187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26442; }","duration":"926.942486ms","start":"2026-10-04T13:43:17.076834Z","end":"2026-10-04T13:43:18.003776Z","steps":["trace[206720187] 'agreement among raft nodes before linearized reading'  (duration: 926.857913ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.605534Z","time spent":"1.3982658s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-10-04T13:43:18.003827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016764535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T13:43:18.003842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:17.076759Z","time spent":"927.073118ms","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-04T13:43:18.003865Z","caller":"traceutil/trace.go:171","msg":"trace[1213840449] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:26442; }","duration":"1.017013s","start":"2026-10-04T13:43:16.986838Z","end":"2026-10-04T13:43:18.003851Z","steps":["trace[1213840449] 'agreement among raft nodes before linearized reading'  (duration: 1.016948499s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.440849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-04T13:43:18.003903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.986812Z","time spent":"1.017082493s","remote":"127.0.0.1:58010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "}
{"level":"info","ts":"2026-10-04T13:43:18.003928Z","caller":"traceutil/trace.go:171","msg":"trace[1603958567] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:26442; }","duration":"355.50842ms","start":"2026-10-04T13:43:17.648393Z","end":"2026-10-04T13:43:18.003902Z","steps":["trace[1603958567] 'agreement among raft nodes before linearized reading'  (duration: 355.452648ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.003932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.397856452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-04T13:43:18.003997Z","caller":"traceutil/trace.go:171","msg":"trace[1290590815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26442; }","duration":"1.397974445s","start":"2026-10-04T13:43:16.606008Z","end":"2026-10-04T13:43:18.003983Z","steps":["trace[1290590815] 'agreement among raft nodes before linearized reading'  (duration: 1.3977382s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.004037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.60598Z","time spent":"1.398051216s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-04T13:43:18.002518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.586693Z","time spent":"1.415738004s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:26425 > 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-10-04T13:43:18.004117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.239981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-10-04T13:43:18.003807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:17.186206Z","time spent":"817.592448ms","remote":"127.0.0.1:34754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T13:43:18.004143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363971398s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-04T13:43:18.004177Z","caller":"traceutil/trace.go:171","msg":"trace[1838700992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26442; }","duration":"1.36404461s","start":"2026-10-04T13:43:16.640122Z","end":"2026-10-04T13:43:18.004167Z","steps":["trace[1838700992] 'agreement among raft nodes before linearized reading'  (duration: 1.363920016s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.004209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.640099Z","time spent":"1.36410477s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-10-04T13:43:18.00423Z","caller":"traceutil/trace.go:171","msg":"trace[348552305] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:26442; }","duration":"462.317283ms","start":"2026-10-04T13:43:17.541824Z","end":"2026-10-04T13:43:18.004141Z","steps":["trace[348552305] 'agreement among raft nodes before linearized reading'  (duration: 462.14974ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.002635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.57752Z","time spent":"1.424965701s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26423 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:18.00426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:17.541788Z","time spent":"462.465366ms","remote":"127.0.0.1:34726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":32,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T13:43:18.00349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.528945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.148\" ","response":"range_response_count:1 size:140"}
{"level":"warn","ts":"2026-10-04T13:43:18.003956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:17.648372Z","time spent":"355.578231ms","remote":"127.0.0.1:49182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "}
{"level":"info","ts":"2026-10-04T13:43:18.002448Z","caller":"traceutil/trace.go:171","msg":"trace[1388631367] transaction","detail":"{read_only:false; response_revision:26437; number_of_response:1; }","duration":"1.482745026s","start":"2026-10-04T13:43:16.519663Z","end":"2026-10-04T13:43:18.002407Z","steps":["trace[1388631367] 'process raft request'  (duration: 1.115513586s)","trace[1388631367] 'compare'  (duration: 366.192019ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:18.004564Z","caller":"traceutil/trace.go:171","msg":"trace[1812701451] range","detail":"{range_begin:/registry/masterleases/162.253.55.148; range_end:; response_count:1; response_revision:26442; }","duration":"933.642298ms","start":"2026-10-04T13:43:17.070892Z","end":"2026-10-04T13:43:18.004535Z","steps":["trace[1812701451] 'agreement among raft nodes before linearized reading'  (duration: 932.415463ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.004599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:17.070863Z","time spent":"933.72607ms","remote":"127.0.0.1:36588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":164,"request content":"key:\"/registry/masterleases/162.253.55.148\" "}
{"level":"warn","ts":"2026-10-04T13:43:18.004676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.519633Z","time spent":"1.484949404s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:26422 > 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-10-04T13:43:18.002632Z","caller":"traceutil/trace.go:171","msg":"trace[249350405] transaction","detail":"{read_only:false; response_revision:26441; number_of_response:1; }","duration":"1.414746043s","start":"2026-10-04T13:43:16.587858Z","end":"2026-10-04T13:43:18.002604Z","steps":["trace[249350405] 'process raft request'  (duration: 1.414421056s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.004793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392791333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-10-04T13:43:18.004862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.587824Z","time spent":"1.416986101s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26426 > 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-10-04T13:43:18.004875Z","caller":"traceutil/trace.go:171","msg":"trace[674324769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26442; }","duration":"1.393982979s","start":"2026-10-04T13:43:16.61084Z","end":"2026-10-04T13:43:18.004823Z","steps":["trace[674324769] 'agreement among raft nodes before linearized reading'  (duration: 1.392747473s)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:18.005121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:16.610828Z","time spent":"1.394275346s","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-10-04T13:43:23.163504Z","caller":"traceutil/trace.go:171","msg":"trace[1674025648] transaction","detail":"{read_only:false; response_revision:26538; number_of_response:1; }","duration":"100.336465ms","start":"2026-10-04T13:43:23.063142Z","end":"2026-10-04T13:43:23.163478Z","steps":["trace[1674025648] 'process raft request'  (duration: 100.029158ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:27.297108Z","caller":"traceutil/trace.go:171","msg":"trace[1987293579] linearizableReadLoop","detail":"{readStateIndex:27476; appliedIndex:27474; }","duration":"221.060366ms","start":"2026-10-04T13:43:27.076008Z","end":"2026-10-04T13:43:27.297069Z","steps":["trace[1987293579] 'read index received'  (duration: 127.094457ms)","trace[1987293579] 'applied index is now lower than readState.Index'  (duration: 93.963529ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:27.297181Z","caller":"traceutil/trace.go:171","msg":"trace[1436845900] transaction","detail":"{read_only:false; response_revision:26590; number_of_response:1; }","duration":"222.130209ms","start":"2026-10-04T13:43:27.075015Z","end":"2026-10-04T13:43:27.297145Z","steps":["trace[1436845900] 'process raft request'  (duration: 221.773931ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:27.297298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.272081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:27.297377Z","caller":"traceutil/trace.go:171","msg":"trace[1065670004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26590; }","duration":"221.420943ms","start":"2026-10-04T13:43:27.075938Z","end":"2026-10-04T13:43:27.297359Z","steps":["trace[1065670004] 'agreement among raft nodes before linearized reading'  (duration: 221.27643ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:27.298384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.572337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:27.298436Z","caller":"traceutil/trace.go:171","msg":"trace[53920345] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:26591; }","duration":"171.67512ms","start":"2026-10-04T13:43:27.126746Z","end":"2026-10-04T13:43:27.298421Z","steps":["trace[53920345] 'agreement among raft nodes before linearized reading'  (duration: 171.557868ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:27.298612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.315061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-10-04T13:43:27.298687Z","caller":"traceutil/trace.go:171","msg":"trace[1874694090] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26591; }","duration":"192.459094ms","start":"2026-10-04T13:43:27.106202Z","end":"2026-10-04T13:43:27.298661Z","steps":["trace[1874694090] 'agreement among raft nodes before linearized reading'  (duration: 192.202178ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.289916Z","caller":"traceutil/trace.go:171","msg":"trace[241093334] transaction","detail":"{read_only:false; response_revision:26665; number_of_response:1; }","duration":"192.399832ms","start":"2026-10-04T13:43:36.097488Z","end":"2026-10-04T13:43:36.289888Z","steps":["trace[241093334] 'process raft request'  (duration: 191.879271ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.290322Z","caller":"traceutil/trace.go:171","msg":"trace[805609309] transaction","detail":"{read_only:false; response_revision:26666; number_of_response:1; }","duration":"188.519001ms","start":"2026-10-04T13:43:36.101756Z","end":"2026-10-04T13:43:36.290275Z","steps":["trace[805609309] 'process raft request'  (duration: 188.02323ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.291121Z","caller":"traceutil/trace.go:171","msg":"trace[941613323] linearizableReadLoop","detail":"{readStateIndex:27556; appliedIndex:27551; }","duration":"154.241317ms","start":"2026-10-04T13:43:36.136862Z","end":"2026-10-04T13:43:36.291103Z","steps":["trace[941613323] 'read index received'  (duration: 152.407398ms)","trace[941613323] 'applied index is now lower than readState.Index'  (duration: 1.832699ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:36.291245Z","caller":"traceutil/trace.go:171","msg":"trace[1851713903] transaction","detail":"{read_only:false; response_revision:26668; number_of_response:1; }","duration":"187.58377ms","start":"2026-10-04T13:43:36.103649Z","end":"2026-10-04T13:43:36.291233Z","steps":["trace[1851713903] 'process raft request'  (duration: 186.877805ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.291336Z","caller":"traceutil/trace.go:171","msg":"trace[29827775] transaction","detail":"{read_only:false; response_revision:26669; number_of_response:1; }","duration":"186.979617ms","start":"2026-10-04T13:43:36.104346Z","end":"2026-10-04T13:43:36.291325Z","steps":["trace[29827775] 'process raft request'  (duration: 186.67986ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.291517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.632985ms","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-10-04T13:43:36.291581Z","caller":"traceutil/trace.go:171","msg":"trace[1761860650] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26669; }","duration":"154.756908ms","start":"2026-10-04T13:43:36.136809Z","end":"2026-10-04T13:43:36.291566Z","steps":["trace[1761860650] 'agreement among raft nodes before linearized reading'  (duration: 154.586075ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.291728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.609925ms","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-10-04T13:43:36.29176Z","caller":"traceutil/trace.go:171","msg":"trace[918658144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26669; }","duration":"147.664996ms","start":"2026-10-04T13:43:36.144087Z","end":"2026-10-04T13:43:36.291752Z","steps":["trace[918658144] 'agreement among raft nodes before linearized reading'  (duration: 147.578765ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.291881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.025353ms","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-10-04T13:43:36.2919Z","caller":"traceutil/trace.go:171","msg":"trace[1852168681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26669; }","duration":"140.070955ms","start":"2026-10-04T13:43:36.151822Z","end":"2026-10-04T13:43:36.291893Z","steps":["trace[1852168681] 'agreement among raft nodes before linearized reading'  (duration: 140.010593ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.291934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.591333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-10-04T13:43:36.291969Z","caller":"traceutil/trace.go:171","msg":"trace[1042304308] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26669; }","duration":"139.653615ms","start":"2026-10-04T13:43:36.152304Z","end":"2026-10-04T13:43:36.291957Z","steps":["trace[1042304308] 'agreement among raft nodes before linearized reading'  (duration: 139.524983ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.292048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.931377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:43:36.292065Z","caller":"traceutil/trace.go:171","msg":"trace[1676789072] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26669; }","duration":"136.951018ms","start":"2026-10-04T13:43:36.155106Z","end":"2026-10-04T13:43:36.292058Z","steps":["trace[1676789072] 'agreement among raft nodes before linearized reading'  (duration: 136.915347ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.292212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.594897ms","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-10-04T13:43:36.292412Z","caller":"traceutil/trace.go:171","msg":"trace[146128016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26669; }","duration":"141.867822ms","start":"2026-10-04T13:43:36.150523Z","end":"2026-10-04T13:43:36.292391Z","steps":["trace[146128016] 'agreement among raft nodes before linearized reading'  (duration: 141.507055ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.290917Z","caller":"traceutil/trace.go:171","msg":"trace[248510733] transaction","detail":"{read_only:false; response_revision:26667; number_of_response:1; }","duration":"187.621281ms","start":"2026-10-04T13:43:36.103235Z","end":"2026-10-04T13:43:36.290856Z","steps":["trace[248510733] 'process raft request'  (duration: 186.917586ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.73416Z","caller":"traceutil/trace.go:171","msg":"trace[1619517048] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"435.004009ms","start":"2026-10-04T13:43:36.299125Z","end":"2026-10-04T13:43:36.734129Z","steps":["trace[1619517048] 'process raft request'  (duration: 434.753763ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.734369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:36.299107Z","time spent":"435.154682ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:26655 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-04T13:43:36.734838Z","caller":"traceutil/trace.go:171","msg":"trace[262988945] transaction","detail":"{read_only:false; response_revision:26672; number_of_response:1; }","duration":"435.467949ms","start":"2026-10-04T13:43:36.299317Z","end":"2026-10-04T13:43:36.734785Z","steps":["trace[262988945] 'process raft request'  (duration: 434.761394ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:36.734877Z","caller":"traceutil/trace.go:171","msg":"trace[1620728082] linearizableReadLoop","detail":"{readStateIndex:27561; appliedIndex:27557; }","duration":"336.82419ms","start":"2026-10-04T13:43:36.398027Z","end":"2026-10-04T13:43:36.734851Z","steps":["trace[1620728082] 'read index received'  (duration: 335.756718ms)","trace[1620728082] 'applied index is now lower than readState.Index'  (duration: 1.066382ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:36.734908Z","caller":"traceutil/trace.go:171","msg":"trace[1824676894] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"435.089321ms","start":"2026-10-04T13:43:36.299792Z","end":"2026-10-04T13:43:36.734881Z","steps":["trace[1824676894] 'process raft request'  (duration: 434.895417ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.735071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:36.299306Z","time spent":"435.635682ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:26652 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-04T13:43:36.735071Z","caller":"traceutil/trace.go:171","msg":"trace[1256557438] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"435.036249ms","start":"2026-10-04T13:43:36.300003Z","end":"2026-10-04T13:43:36.73504Z","steps":["trace[1256557438] 'process raft request'  (duration: 434.797744ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.735223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:36.299992Z","time spent":"435.150292ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26653 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:36.735301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.263779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-04T13:43:36.735365Z","caller":"traceutil/trace.go:171","msg":"trace[554487469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26674; }","duration":"337.327971ms","start":"2026-10-04T13:43:36.398017Z","end":"2026-10-04T13:43:36.735345Z","steps":["trace[554487469] 'agreement among raft nodes before linearized reading'  (duration: 337.088856ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:36.735405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:36.397957Z","time spent":"337.437584ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-10-04T13:43:36.735688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:36.299781Z","time spent":"435.229994ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26654 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:37.026277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.840232ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158039417 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26658 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:43:37.026399Z","caller":"traceutil/trace.go:171","msg":"trace[758965280] linearizableReadLoop","detail":"{readStateIndex:27562; appliedIndex:27561; }","duration":"135.094638ms","start":"2026-10-04T13:43:36.891288Z","end":"2026-10-04T13:43:37.026382Z","steps":["trace[758965280] 'read index received'  (duration: 58.041µs)","trace[758965280] 'applied index is now lower than readState.Index'  (duration: 135.034957ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:37.026516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.228651ms","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-10-04T13:43:37.026581Z","caller":"traceutil/trace.go:171","msg":"trace[765016113] 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:26675; }","duration":"135.340703ms","start":"2026-10-04T13:43:36.891225Z","end":"2026-10-04T13:43:37.026566Z","steps":["trace[765016113] 'agreement among raft nodes before linearized reading'  (duration: 135.202981ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:37.026827Z","caller":"traceutil/trace.go:171","msg":"trace[1701215148] transaction","detail":"{read_only:false; response_revision:26675; number_of_response:1; }","duration":"286.531426ms","start":"2026-10-04T13:43:36.740283Z","end":"2026-10-04T13:43:37.026814Z","steps":["trace[1701215148] 'process raft request'  (duration: 78.024449ms)","trace[1701215148] 'compare'  (duration: 207.681429ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:38.435292Z","caller":"traceutil/trace.go:171","msg":"trace[408418545] transaction","detail":"{read_only:false; response_revision:26680; number_of_response:1; }","duration":"137.603941ms","start":"2026-10-04T13:43:38.297661Z","end":"2026-10-04T13:43:38.435265Z","steps":["trace[408418545] 'process raft request'  (duration: 137.364916ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:38.435743Z","caller":"traceutil/trace.go:171","msg":"trace[1640141431] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"137.216084ms","start":"2026-10-04T13:43:38.298487Z","end":"2026-10-04T13:43:38.435704Z","steps":["trace[1640141431] 'process raft request'  (duration: 136.718903ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:38.435836Z","caller":"traceutil/trace.go:171","msg":"trace[316643891] transaction","detail":"{read_only:false; response_revision:26682; number_of_response:1; }","duration":"134.534236ms","start":"2026-10-04T13:43:38.301274Z","end":"2026-10-04T13:43:38.435809Z","steps":["trace[316643891] 'process raft request'  (duration: 134.294391ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:38.435886Z","caller":"traceutil/trace.go:171","msg":"trace[41914420] transaction","detail":"{read_only:false; response_revision:26683; number_of_response:1; }","duration":"134.502794ms","start":"2026-10-04T13:43:38.301346Z","end":"2026-10-04T13:43:38.435849Z","steps":["trace[41914420] 'process raft request'  (duration: 134.370812ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:40.199256Z","caller":"traceutil/trace.go:171","msg":"trace[802204368] transaction","detail":"{read_only:false; response_revision:26694; number_of_response:1; }","duration":"204.979141ms","start":"2026-10-04T13:43:39.994238Z","end":"2026-10-04T13:43:40.199217Z","steps":["trace[802204368] 'process raft request'  (duration: 204.799858ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:40.345901Z","caller":"traceutil/trace.go:171","msg":"trace[156079350] linearizableReadLoop","detail":"{readStateIndex:27583; appliedIndex:27581; }","duration":"200.665039ms","start":"2026-10-04T13:43:40.145188Z","end":"2026-10-04T13:43:40.345853Z","steps":["trace[156079350] 'read index received'  (duration: 53.773389ms)","trace[156079350] 'applied index is now lower than readState.Index'  (duration: 146.8904ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:40.346152Z","caller":"traceutil/trace.go:171","msg":"trace[1683657935] transaction","detail":"{read_only:false; response_revision:26695; number_of_response:1; }","duration":"209.416248ms","start":"2026-10-04T13:43:40.136721Z","end":"2026-10-04T13:43:40.346137Z","steps":["trace[1683657935] 'process raft request'  (duration: 204.299968ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:40.346395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.18533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:40.346442Z","caller":"traceutil/trace.go:171","msg":"trace[1790212907] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:26695; }","duration":"201.286362ms","start":"2026-10-04T13:43:40.145139Z","end":"2026-10-04T13:43:40.346425Z","steps":["trace[1790212907] 'agreement among raft nodes before linearized reading'  (duration: 201.193551ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:42.614313Z","caller":"traceutil/trace.go:171","msg":"trace[1458651041] transaction","detail":"{read_only:false; response_revision:26709; number_of_response:1; }","duration":"223.207341ms","start":"2026-10-04T13:43:42.391063Z","end":"2026-10-04T13:43:42.61427Z","steps":["trace[1458651041] 'process raft request'  (duration: 205.908521ms)","trace[1458651041] 'compare'  (duration: 16.962764ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:42.618669Z","caller":"traceutil/trace.go:171","msg":"trace[52381410] transaction","detail":"{read_only:false; response_revision:26711; number_of_response:1; }","duration":"142.380554ms","start":"2026-10-04T13:43:42.476253Z","end":"2026-10-04T13:43:42.618634Z","steps":["trace[52381410] 'process raft request'  (duration: 142.21786ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:42.618692Z","caller":"traceutil/trace.go:171","msg":"trace[514309080] transaction","detail":"{read_only:false; response_revision:26713; number_of_response:1; }","duration":"142.053377ms","start":"2026-10-04T13:43:42.476608Z","end":"2026-10-04T13:43:42.618662Z","steps":["trace[514309080] 'process raft request'  (duration: 141.972136ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:42.618903Z","caller":"traceutil/trace.go:171","msg":"trace[1388435782] transaction","detail":"{read_only:false; response_revision:26712; number_of_response:1; }","duration":"142.297952ms","start":"2026-10-04T13:43:42.476588Z","end":"2026-10-04T13:43:42.618886Z","steps":["trace[1388435782] 'process raft request'  (duration: 141.932054ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:42.61916Z","caller":"traceutil/trace.go:171","msg":"trace[1017035198] transaction","detail":"{read_only:false; response_revision:26710; number_of_response:1; }","duration":"143.030448ms","start":"2026-10-04T13:43:42.47611Z","end":"2026-10-04T13:43:42.61914Z","steps":["trace[1017035198] 'process raft request'  (duration: 142.221021ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:42.62158Z","caller":"traceutil/trace.go:171","msg":"trace[1994912302] linearizableReadLoop","detail":"{readStateIndex:27601; appliedIndex:27596; }","duration":"131.711615ms","start":"2026-10-04T13:43:42.489817Z","end":"2026-10-04T13:43:42.621529Z","steps":["trace[1994912302] 'read index received'  (duration: 107.175281ms)","trace[1994912302] 'applied index is now lower than readState.Index'  (duration: 24.534804ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:42.621813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.9757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:43:42.621879Z","caller":"traceutil/trace.go:171","msg":"trace[1962413601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26713; }","duration":"132.108224ms","start":"2026-10-04T13:43:42.489749Z","end":"2026-10-04T13:43:42.621858Z","steps":["trace[1962413601] 'agreement among raft nodes before linearized reading'  (duration: 131.892709ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:47.016474Z","caller":"traceutil/trace.go:171","msg":"trace[1039952527] linearizableReadLoop","detail":"{readStateIndex:27644; appliedIndex:27643; }","duration":"189.320767ms","start":"2026-10-04T13:43:46.827122Z","end":"2026-10-04T13:43:47.016443Z","steps":["trace[1039952527] 'read index received'  (duration: 75.30003ms)","trace[1039952527] 'applied index is now lower than readState.Index'  (duration: 114.019387ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:47.016637Z","caller":"traceutil/trace.go:171","msg":"trace[837100368] transaction","detail":"{read_only:false; response_revision:26755; number_of_response:1; }","duration":"204.00473ms","start":"2026-10-04T13:43:46.812616Z","end":"2026-10-04T13:43:47.01662Z","steps":["trace[837100368] 'process raft request'  (duration: 190.596184ms)","trace[837100368] 'compare'  (duration: 13.07556ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:47.016893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.187573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-04T13:43:47.016935Z","caller":"traceutil/trace.go:171","msg":"trace[238973634] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26755; }","duration":"188.293195ms","start":"2026-10-04T13:43:46.828631Z","end":"2026-10-04T13:43:47.016924Z","steps":["trace[238973634] 'agreement among raft nodes before linearized reading'  (duration: 188.125602ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:47.016943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.791197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-04T13:43:47.017028Z","caller":"traceutil/trace.go:171","msg":"trace[1428225841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26755; }","duration":"189.903889ms","start":"2026-10-04T13:43:46.827105Z","end":"2026-10-04T13:43:47.017009Z","steps":["trace[1428225841] 'agreement among raft nodes before linearized reading'  (duration: 189.685075ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:51.676229Z","caller":"traceutil/trace.go:171","msg":"trace[1559618446] transaction","detail":"{read_only:false; response_revision:26794; number_of_response:1; }","duration":"116.370507ms","start":"2026-10-04T13:43:51.55983Z","end":"2026-10-04T13:43:51.676201Z","steps":["trace[1559618446] 'process raft request'  (duration: 116.166093ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:53.719247Z","caller":"traceutil/trace.go:171","msg":"trace[1354584028] transaction","detail":"{read_only:false; response_revision:26807; number_of_response:1; }","duration":"133.139296ms","start":"2026-10-04T13:43:53.586079Z","end":"2026-10-04T13:43:53.719218Z","steps":["trace[1354584028] 'process raft request'  (duration: 132.961672ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:57.896389Z","caller":"traceutil/trace.go:171","msg":"trace[1616456962] transaction","detail":"{read_only:false; response_revision:26839; number_of_response:1; }","duration":"162.527944ms","start":"2026-10-04T13:43:57.733825Z","end":"2026-10-04T13:43:57.896353Z","steps":["trace[1616456962] 'process raft request'  (duration: 162.34568ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:58.226264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.819563ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:58.226427Z","caller":"traceutil/trace.go:171","msg":"trace[2130112843] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26839; }","duration":"165.011858ms","start":"2026-10-04T13:43:58.061391Z","end":"2026-10-04T13:43:58.226403Z","steps":["trace[2130112843] 'range keys from in-memory index tree'  (duration: 164.797453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:58.226831Z","caller":"traceutil/trace.go:171","msg":"trace[487994011] linearizableReadLoop","detail":"{readStateIndex:27732; appliedIndex:27731; }","duration":"148.630497ms","start":"2026-10-04T13:43:58.07818Z","end":"2026-10-04T13:43:58.226811Z","steps":["trace[487994011] 'read index received'  (duration: 103.84333ms)","trace[487994011] 'applied index is now lower than readState.Index'  (duration: 44.785967ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:58.227106Z","caller":"traceutil/trace.go:171","msg":"trace[1312779361] transaction","detail":"{read_only:false; response_revision:26840; number_of_response:1; }","duration":"326.545951ms","start":"2026-10-04T13:43:57.90054Z","end":"2026-10-04T13:43:58.227086Z","steps":["trace[1312779361] 'process raft request'  (duration: 281.624861ms)","trace[1312779361] 'compare'  (duration: 44.372688ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:58.227257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:43:57.90052Z","time spent":"326.636672ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:26719 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T13:43:58.227692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.513346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:58.227741Z","caller":"traceutil/trace.go:171","msg":"trace[1639614263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26840; }","duration":"149.564197ms","start":"2026-10-04T13:43:58.078164Z","end":"2026-10-04T13:43:58.227729Z","steps":["trace[1639614263] 'agreement among raft nodes before linearized reading'  (duration: 148.758729ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:58.892756Z","caller":"traceutil/trace.go:171","msg":"trace[1142580317] linearizableReadLoop","detail":"{readStateIndex:27738; appliedIndex:27733; }","duration":"171.442764ms","start":"2026-10-04T13:43:58.721264Z","end":"2026-10-04T13:43:58.892706Z","steps":["trace[1142580317] 'read index received'  (duration: 48.998007ms)","trace[1142580317] 'applied index is now lower than readState.Index'  (duration: 122.443387ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:58.893047Z","caller":"traceutil/trace.go:171","msg":"trace[168982875] transaction","detail":"{read_only:false; response_revision:26843; number_of_response:1; }","duration":"198.988265ms","start":"2026-10-04T13:43:58.694044Z","end":"2026-10-04T13:43:58.893033Z","steps":["trace[168982875] 'process raft request'  (duration: 194.168251ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:58.893347Z","caller":"traceutil/trace.go:171","msg":"trace[249138511] transaction","detail":"{read_only:false; response_revision:26844; number_of_response:1; }","duration":"197.235535ms","start":"2026-10-04T13:43:58.696097Z","end":"2026-10-04T13:43:58.893332Z","steps":["trace[249138511] 'process raft request'  (duration: 196.422458ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:58.89355Z","caller":"traceutil/trace.go:171","msg":"trace[505180094] transaction","detail":"{read_only:false; response_revision:26845; number_of_response:1; }","duration":"197.145075ms","start":"2026-10-04T13:43:58.696392Z","end":"2026-10-04T13:43:58.893537Z","steps":["trace[505180094] 'process raft request'  (duration: 196.233475ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:58.893757Z","caller":"traceutil/trace.go:171","msg":"trace[805012043] transaction","detail":"{read_only:false; response_revision:26846; number_of_response:1; }","duration":"195.870688ms","start":"2026-10-04T13:43:58.697872Z","end":"2026-10-04T13:43:58.893743Z","steps":["trace[805012043] 'process raft request'  (duration: 194.794994ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:58.894067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.773473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-04T13:43:58.894127Z","caller":"traceutil/trace.go:171","msg":"trace[1136598125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26846; }","duration":"172.852685ms","start":"2026-10-04T13:43:58.721254Z","end":"2026-10-04T13:43:58.894107Z","steps":["trace[1136598125] 'agreement among raft nodes before linearized reading'  (duration: 172.650561ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:58.894383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.401555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:43:58.894438Z","caller":"traceutil/trace.go:171","msg":"trace[1376257589] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:26846; }","duration":"128.512478ms","start":"2026-10-04T13:43:58.765912Z","end":"2026-10-04T13:43:58.894424Z","steps":["trace[1376257589] 'agreement among raft nodes before linearized reading'  (duration: 128.403606ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:59.22172Z","caller":"traceutil/trace.go:171","msg":"trace[1441771540] linearizableReadLoop","detail":"{readStateIndex:27740; appliedIndex:27739; }","duration":"130.753876ms","start":"2026-10-04T13:43:59.090939Z","end":"2026-10-04T13:43:59.221693Z","steps":["trace[1441771540] 'read index received'  (duration: 51.761498ms)","trace[1441771540] 'applied index is now lower than readState.Index'  (duration: 78.991168ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:59.222033Z","caller":"traceutil/trace.go:171","msg":"trace[1063407854] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"239.388137ms","start":"2026-10-04T13:43:58.982627Z","end":"2026-10-04T13:43:59.222015Z","steps":["trace[1063407854] 'process raft request'  (duration: 160.102612ms)","trace[1063407854] 'compare'  (duration: 77.868975ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:43:59.222346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.389138ms","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-10-04T13:43:59.22239Z","caller":"traceutil/trace.go:171","msg":"trace[2096944110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26848; }","duration":"131.497881ms","start":"2026-10-04T13:43:59.09088Z","end":"2026-10-04T13:43:59.222378Z","steps":["trace[2096944110] 'agreement among raft nodes before linearized reading'  (duration: 131.343968ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:59.22261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.05887ms","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-10-04T13:43:59.222719Z","caller":"traceutil/trace.go:171","msg":"trace[78816851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26848; }","duration":"130.224304ms","start":"2026-10-04T13:43:59.092474Z","end":"2026-10-04T13:43:59.222698Z","steps":["trace[78816851] 'agreement among raft nodes before linearized reading'  (duration: 129.925377ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:59.222947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.890583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-10-04T13:43:59.222977Z","caller":"traceutil/trace.go:171","msg":"trace[1531111106] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26848; }","duration":"119.942845ms","start":"2026-10-04T13:43:59.103023Z","end":"2026-10-04T13:43:59.222966Z","steps":["trace[1531111106] 'agreement among raft nodes before linearized reading'  (duration: 119.874143ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:59.425736Z","caller":"traceutil/trace.go:171","msg":"trace[926103361] linearizableReadLoop","detail":"{readStateIndex:27744; appliedIndex:27740; }","duration":"198.664397ms","start":"2026-10-04T13:43:59.227044Z","end":"2026-10-04T13:43:59.425709Z","steps":["trace[926103361] 'read index received'  (duration: 63.59616ms)","trace[926103361] 'applied index is now lower than readState.Index'  (duration: 135.067197ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:43:59.426036Z","caller":"traceutil/trace.go:171","msg":"trace[2009179361] transaction","detail":"{read_only:false; response_revision:26850; number_of_response:1; }","duration":"199.2978ms","start":"2026-10-04T13:43:59.226724Z","end":"2026-10-04T13:43:59.426022Z","steps":["trace[2009179361] 'process raft request'  (duration: 198.640206ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:59.426235Z","caller":"traceutil/trace.go:171","msg":"trace[1457818885] transaction","detail":"{read_only:false; response_revision:26851; number_of_response:1; }","duration":"199.370363ms","start":"2026-10-04T13:43:59.226855Z","end":"2026-10-04T13:43:59.426225Z","steps":["trace[1457818885] 'process raft request'  (duration: 198.725338ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:59.426367Z","caller":"traceutil/trace.go:171","msg":"trace[1023951120] transaction","detail":"{read_only:false; response_revision:26852; number_of_response:1; }","duration":"199.499275ms","start":"2026-10-04T13:43:59.226858Z","end":"2026-10-04T13:43:59.426358Z","steps":["trace[1023951120] 'process raft request'  (duration: 198.765559ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:43:59.426497Z","caller":"traceutil/trace.go:171","msg":"trace[1127280033] transaction","detail":"{read_only:false; response_revision:26853; number_of_response:1; }","duration":"150.006986ms","start":"2026-10-04T13:43:59.276478Z","end":"2026-10-04T13:43:59.426485Z","steps":["trace[1127280033] 'process raft request'  (duration: 149.184059ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:59.426751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.698209ms","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-10-04T13:43:59.426813Z","caller":"traceutil/trace.go:171","msg":"trace[1155154998] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26853; }","duration":"199.777381ms","start":"2026-10-04T13:43:59.227026Z","end":"2026-10-04T13:43:59.426804Z","steps":["trace[1155154998] 'agreement among raft nodes before linearized reading'  (duration: 199.654908ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:43:59.426998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.986869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:43:59.427048Z","caller":"traceutil/trace.go:171","msg":"trace[2020736559] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:26853; }","duration":"181.082141ms","start":"2026-10-04T13:43:59.245951Z","end":"2026-10-04T13:43:59.427033Z","steps":["trace[2020736559] 'agreement among raft nodes before linearized reading'  (duration: 181.005739ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:44:03.675384Z","caller":"traceutil/trace.go:171","msg":"trace[1089805149] transaction","detail":"{read_only:false; response_revision:26881; number_of_response:1; }","duration":"172.971907ms","start":"2026-10-04T13:44:03.502369Z","end":"2026-10-04T13:44:03.675341Z","steps":["trace[1089805149] 'process raft request'  (duration: 76.766601ms)","trace[1089805149] 'compare'  (duration: 96.040533ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:44:05.559006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.255407ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677940158039973 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:26878 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-04T13:44:05.559239Z","caller":"traceutil/trace.go:171","msg":"trace[848531183] transaction","detail":"{read_only:false; response_revision:26892; number_of_response:1; }","duration":"238.342706ms","start":"2026-10-04T13:44:05.320856Z","end":"2026-10-04T13:44:05.559199Z","steps":["trace[848531183] 'process raft request'  (duration: 68.769101ms)","trace[848531183] 'compare'  (duration: 168.496522ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:44:11.211457Z","caller":"traceutil/trace.go:171","msg":"trace[1804904096] transaction","detail":"{read_only:false; response_revision:26931; number_of_response:1; }","duration":"266.514497ms","start":"2026-10-04T13:44:10.944907Z","end":"2026-10-04T13:44:11.211421Z","steps":["trace[1804904096] 'process raft request'  (duration: 266.291172ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:44:11.405487Z","caller":"traceutil/trace.go:171","msg":"trace[2108631448] linearizableReadLoop","detail":"{readStateIndex:27828; appliedIndex:27824; }","duration":"382.820464ms","start":"2026-10-04T13:44:11.022638Z","end":"2026-10-04T13:44:11.405459Z","steps":["trace[2108631448] 'read index received'  (duration: 188.536271ms)","trace[2108631448] 'applied index is now lower than readState.Index'  (duration: 194.282873ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:44:11.405669Z","caller":"traceutil/trace.go:171","msg":"trace[452221981] transaction","detail":"{read_only:false; response_revision:26932; number_of_response:1; }","duration":"445.369021ms","start":"2026-10-04T13:44:10.960286Z","end":"2026-10-04T13:44:11.405655Z","steps":["trace[452221981] 'process raft request'  (duration: 382.462466ms)","trace[452221981] 'compare'  (duration: 62.246111ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-04T13:44:11.405807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:44:10.96025Z","time spent":"445.449153ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:26916 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-10-04T13:44:11.405854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.188792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-04T13:44:11.4059Z","caller":"traceutil/trace.go:171","msg":"trace[278446878] transaction","detail":"{read_only:false; response_revision:26933; number_of_response:1; }","duration":"444.85927ms","start":"2026-10-04T13:44:10.96099Z","end":"2026-10-04T13:44:11.405849Z","steps":["trace[278446878] 'process raft request'  (duration: 444.296868ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:44:11.405963Z","caller":"traceutil/trace.go:171","msg":"trace[58480319] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:26934; }","duration":"383.396566ms","start":"2026-10-04T13:44:11.022544Z","end":"2026-10-04T13:44:11.405941Z","steps":["trace[58480319] 'agreement among raft nodes before linearized reading'  (duration: 383.13289ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:44:11.405971Z","caller":"traceutil/trace.go:171","msg":"trace[1759423236] transaction","detail":"{read_only:false; response_revision:26934; number_of_response:1; }","duration":"443.058241ms","start":"2026-10-04T13:44:10.962885Z","end":"2026-10-04T13:44:11.405944Z","steps":["trace[1759423236] 'process raft request'  (duration: 442.484298ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:44:11.406022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:44:11.022516Z","time spent":"383.490869ms","remote":"127.0.0.1:37008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":54,"response size":32,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"warn","ts":"2026-10-04T13:44:11.406011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.642289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-10-04T13:44:11.406066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:44:10.96285Z","time spent":"443.169074ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:26918 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-10-04T13:44:11.406096Z","caller":"traceutil/trace.go:171","msg":"trace[2127468843] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26934; }","duration":"352.791931ms","start":"2026-10-04T13:44:11.053281Z","end":"2026-10-04T13:44:11.406073Z","steps":["trace[2127468843] 'agreement among raft nodes before linearized reading'  (duration: 352.563866ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:44:11.406131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:44:11.053257Z","time spent":"352.867533ms","remote":"127.0.0.1:36820","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-10-04T13:44:11.406143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:44:10.960974Z","time spent":"445.027574ms","remote":"127.0.0.1:36820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26917 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-04T13:44:11.406197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.577035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:44:11.406283Z","caller":"traceutil/trace.go:171","msg":"trace[68602546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26934; }","duration":"328.759008ms","start":"2026-10-04T13:44:11.077504Z","end":"2026-10-04T13:44:11.406263Z","steps":["trace[68602546] 'agreement among raft nodes before linearized reading'  (duration: 328.629145ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:44:11.406321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T13:44:11.077476Z","time spent":"328.836748ms","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-04T13:44:13.378635Z","caller":"traceutil/trace.go:171","msg":"trace[1347363113] transaction","detail":"{read_only:false; response_revision:26945; number_of_response:1; }","duration":"110.811069ms","start":"2026-10-04T13:44:13.267785Z","end":"2026-10-04T13:44:13.378596Z","steps":["trace[1347363113] 'process raft request'  (duration: 105.756331ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:44:41.179932Z","caller":"traceutil/trace.go:171","msg":"trace[1344538086] linearizableReadLoop","detail":"{readStateIndex:28205; appliedIndex:28204; }","duration":"117.726376ms","start":"2026-10-04T13:44:41.062163Z","end":"2026-10-04T13:44:41.179889Z","steps":["trace[1344538086] 'read index received'  (duration: 117.350828ms)","trace[1344538086] 'applied index is now lower than readState.Index'  (duration: 373.998µs)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:44:41.180103Z","caller":"traceutil/trace.go:171","msg":"trace[1511257893] transaction","detail":"{read_only:false; response_revision:27303; number_of_response:1; }","duration":"188.905329ms","start":"2026-10-04T13:44:40.991134Z","end":"2026-10-04T13:44:41.180039Z","steps":["trace[1511257893] 'process raft request'  (duration: 188.52072ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:44:41.180199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.006332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:44:41.180248Z","caller":"traceutil/trace.go:171","msg":"trace[197356271] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:27303; }","duration":"118.137676ms","start":"2026-10-04T13:44:41.062095Z","end":"2026-10-04T13:44:41.180232Z","steps":["trace[197356271] 'agreement among raft nodes before linearized reading'  (duration: 118.012652ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:44:41.180334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.086692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-04T13:44:41.18049Z","caller":"traceutil/trace.go:171","msg":"trace[662968447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27303; }","duration":"102.313567ms","start":"2026-10-04T13:44:41.078143Z","end":"2026-10-04T13:44:41.180457Z","steps":["trace[662968447] 'agreement among raft nodes before linearized reading'  (duration: 102.049372ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:45:03.808847Z","caller":"traceutil/trace.go:171","msg":"trace[848852443] linearizableReadLoop","detail":"{readStateIndex:28428; appliedIndex:28425; }","duration":"120.634789ms","start":"2026-10-04T13:45:03.68819Z","end":"2026-10-04T13:45:03.808825Z","steps":["trace[848852443] 'read index received'  (duration: 39.075915ms)","trace[848852443] 'applied index is now lower than readState.Index'  (duration: 81.557793ms)"],"step_count":2}
{"level":"info","ts":"2026-10-04T13:45:03.808893Z","caller":"traceutil/trace.go:171","msg":"trace[1937248807] transaction","detail":"{read_only:false; response_revision:27520; number_of_response:1; }","duration":"134.659899ms","start":"2026-10-04T13:45:03.674197Z","end":"2026-10-04T13:45:03.808857Z","steps":["trace[1937248807] 'process raft request'  (duration: 134.374343ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:45:03.808986Z","caller":"traceutil/trace.go:171","msg":"trace[209436946] transaction","detail":"{read_only:false; response_revision:27521; number_of_response:1; }","duration":"132.977082ms","start":"2026-10-04T13:45:03.675958Z","end":"2026-10-04T13:45:03.808935Z","steps":["trace[209436946] 'process raft request'  (duration: 132.817818ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-04T13:45:03.809081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.851784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-10-04T13:45:03.809119Z","caller":"traceutil/trace.go:171","msg":"trace[1878593109] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:27521; }","duration":"120.961867ms","start":"2026-10-04T13:45:03.688145Z","end":"2026-10-04T13:45:03.809107Z","steps":["trace[1878593109] 'agreement among raft nodes before linearized reading'  (duration: 120.802584ms)"],"step_count":1}
{"level":"info","ts":"2026-10-04T13:45:33.663157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24994}
{"level":"info","ts":"2026-10-04T13:45:33.811523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24994,"took":"144.213079ms","hash":23345984,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":36380672,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-04T13:45:33.81161Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":23345984,"revision":24994,"compact-revision":21810}
{"level":"info","ts":"2026-10-04T13:47:44.909656Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T13:47:44.916535Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-04T13:47:44.916638Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-04T13:50:33.669736Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27786}
{"level":"info","ts":"2026-10-04T13:50:33.822218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27786,"took":"147.361898ms","hash":599446864,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":34508800,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-04T13:50:33.8223Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":599446864,"revision":27786,"compact-revision":24994}
{"level":"info","ts":"2026-10-04T13:55:33.677189Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30456}
{"level":"info","ts":"2026-10-04T13:55:33.833256Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30456,"took":"148.02395ms","hash":2546729915,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":30679040,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T13:55:33.833331Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2546729915,"revision":30456,"compact-revision":27786}
{"level":"info","ts":"2026-10-04T14:00:33.687428Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32704}
{"level":"info","ts":"2026-10-04T14:00:33.954609Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32704,"took":"258.699246ms","hash":3982103048,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":30638080,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T14:00:33.954719Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3982103048,"revision":32704,"compact-revision":30456}
{"level":"info","ts":"2026-10-04T14:05:33.698722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34989}
{"level":"info","ts":"2026-10-04T14:05:33.827542Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34989,"took":"124.592181ms","hash":2214841532,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":31412224,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T14:05:33.827615Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2214841532,"revision":34989,"compact-revision":32704}
{"level":"info","ts":"2026-10-04T14:08:48.432003Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-04T14:08:48.441898Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-04T14:08:48.442166Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-04T14:10:33.706441Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37311}
{"level":"info","ts":"2026-10-04T14:10:33.848978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37311,"took":"135.505352ms","hash":4250856148,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":32997376,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-04T14:10:33.849058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4250856148,"revision":37311,"compact-revision":34989}
{"level":"info","ts":"2026-10-04T14:15:33.714149Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39596}
{"level":"info","ts":"2026-10-04T14:15:33.852964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39596,"took":"131.977497ms","hash":3950958684,"current-db-size-bytes":61050880,"current-db-size":"61 MB","current-db-size-in-use-bytes":32239616,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-04T14:15:33.853049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3950958684,"revision":39596,"compact-revision":37311}
{"level":"info","ts":"2026-10-04T14:20:33.720829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41825}
{"level":"info","ts":"2026-10-04T14:20:33.850539Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41825,"took":"124.550199ms","hash":3860526128,"current-db-size-bytes":61050880,"current-db-size":"61 MB","current-db-size-in-use-bytes":30670848,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-04T14:20:33.850613Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3860526128,"revision":41825,"compact-revision":39596}