{"level":"warn","ts":"2026-03-17T22:00:28.401115Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-17T22:00:28.401227Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.149:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.149:2380","--initial-cluster=instance=https://199.204.45.149:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.149:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.149:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-17T22:00:28.401297Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-17T22:00:28.401309Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.149:2380"]}
{"level":"info","ts":"2026-03-17T22:00:28.401329Z","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-03-17T22:00:28.401976Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"]}
{"level":"info","ts":"2026-03-17T22:00:28.40206Z","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://199.204.45.149:2380"],"listen-peer-urls":["https://199.204.45.149:2380"],"advertise-client-urls":["https://199.204.45.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.149:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-17T22:00:28.406042Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.746254ms"}
{"level":"info","ts":"2026-03-17T22:00:28.415914Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b1b675f124322401","cluster-id":"913dfbf24a38e0aa"}
{"level":"info","ts":"2026-03-17T22:00:28.416063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-17T22:00:28.416096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became follower at term 0"}
{"level":"info","ts":"2026-03-17T22:00:28.416115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b1b675f124322401 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-17T22:00:28.416144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became follower at term 1"}
{"level":"info","ts":"2026-03-17T22:00:28.416204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=(12805552269029417985)"}
{"level":"warn","ts":"2026-03-17T22:00:28.427608Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-17T22:00:28.429688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-17T22:00:28.430991Z","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-03-17T22:00:28.434239Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b1b675f124322401","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-17T22:00:28.435334Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b1b675f124322401","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-17T22:00:28.435461Z","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-03-17T22:00:28.435596Z","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-03-17T22:00:28.435614Z","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-03-17T22:00:28.437373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=(12805552269029417985)"}
{"level":"info","ts":"2026-03-17T22:00:28.438686Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"913dfbf24a38e0aa","local-member-id":"b1b675f124322401","added-peer-id":"b1b675f124322401","added-peer-peer-urls":["https://199.204.45.149:2380"]}
{"level":"info","ts":"2026-03-17T22:00:28.440178Z","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-03-17T22:00:28.440317Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.149:2380"}
{"level":"info","ts":"2026-03-17T22:00:28.440375Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.149:2380"}
{"level":"info","ts":"2026-03-17T22:00:28.440525Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b1b675f124322401","initial-advertise-peer-urls":["https://199.204.45.149:2380"],"listen-peer-urls":["https://199.204.45.149:2380"],"advertise-client-urls":["https://199.204.45.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-17T22:00:28.440562Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-17T22:00:29.216789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-17T22:00:29.216862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-17T22:00:29.216881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 received MsgPreVoteResp from b1b675f124322401 at term 1"}
{"level":"info","ts":"2026-03-17T22:00:29.216898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became candidate at term 2"}
{"level":"info","ts":"2026-03-17T22:00:29.216906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 received MsgVoteResp from b1b675f124322401 at term 2"}
{"level":"info","ts":"2026-03-17T22:00:29.216919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became leader at term 2"}
{"level":"info","ts":"2026-03-17T22:00:29.21693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b1b675f124322401 elected leader b1b675f124322401 at term 2"}
{"level":"info","ts":"2026-03-17T22:00:29.218245Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b1b675f124322401","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.149:2379]}","request-path":"/0/members/b1b675f124322401/attributes","cluster-id":"913dfbf24a38e0aa","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-17T22:00:29.218299Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-17T22:00:29.218376Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-17T22:00:29.218394Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T22:00:29.21868Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-17T22:00:29.218792Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-17T22:00:29.219584Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"913dfbf24a38e0aa","local-member-id":"b1b675f124322401","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T22:00:29.21969Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T22:00:29.219729Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T22:00:29.221424Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.149:2379"}
{"level":"info","ts":"2026-03-17T22:00:29.222216Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-17T22:00:33.915041Z","caller":"traceutil/trace.go:171","msg":"trace[537372504] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"100.977931ms","start":"2026-03-17T22:00:33.814028Z","end":"2026-03-17T22:00:33.915005Z","steps":["trace[537372504] 'process raft request'  (duration: 76.305519ms)","trace[537372504] 'compare'  (duration: 24.527588ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:00:37.07514Z","caller":"traceutil/trace.go:171","msg":"trace[1823676277] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"659.310155ms","start":"2026-03-17T22:00:36.415775Z","end":"2026-03-17T22:00:37.075085Z","steps":["trace[1823676277] 'process raft request'  (duration: 659.088279ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:00:37.075961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:36.415745Z","time spent":"659.546352ms","remote":"127.0.0.1:35582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/disruption-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/disruption-controller\" value_size:126 >> failure:<>"}
{"level":"warn","ts":"2026-03-17T22:00:37.514864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.800066ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281480916 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:302 > 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-03-17T22:00:37.515058Z","caller":"traceutil/trace.go:171","msg":"trace[1764910479] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:327; }","duration":"432.65092ms","start":"2026-03-17T22:00:37.082383Z","end":"2026-03-17T22:00:37.515034Z","steps":["trace[1764910479] 'read index received'  (duration: 55.307999ms)","trace[1764910479] 'applied index is now lower than readState.Index'  (duration: 377.341201ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:00:37.515148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.749753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:00:37.515197Z","caller":"traceutil/trace.go:171","msg":"trace[1785296414] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:0; response_revision:319; }","duration":"432.817985ms","start":"2026-03-17T22:00:37.082365Z","end":"2026-03-17T22:00:37.515183Z","steps":["trace[1785296414] 'agreement among raft nodes before linearized reading'  (duration: 432.733703ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:00:37.51525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:37.082357Z","time spent":"432.881417ms","remote":"127.0.0.1:35582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "}
{"level":"info","ts":"2026-03-17T22:00:37.515412Z","caller":"traceutil/trace.go:171","msg":"trace[43853382] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"435.88195ms","start":"2026-03-17T22:00:37.079505Z","end":"2026-03-17T22:00:37.515387Z","steps":["trace[43853382] 'process raft request'  (duration: 58.168488ms)","trace[43853382] 'compare'  (duration: 376.619162ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:00:37.515512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:37.07949Z","time spent":"435.973842ms","remote":"127.0.0.1:35660","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:302 > 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-03-17T22:00:37.757655Z","caller":"traceutil/trace.go:171","msg":"trace[248630189] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"233.935156ms","start":"2026-03-17T22:00:37.52369Z","end":"2026-03-17T22:00:37.757625Z","steps":["trace[248630189] 'process raft request'  (duration: 232.718463ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:00:37.921908Z","caller":"traceutil/trace.go:171","msg":"trace[1000757677] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"152.881896ms","start":"2026-03-17T22:00:37.768995Z","end":"2026-03-17T22:00:37.921877Z","steps":["trace[1000757677] 'process raft request'  (duration: 135.680461ms)","trace[1000757677] 'compare'  (duration: 17.055021ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:01.511286Z","caller":"traceutil/trace.go:171","msg":"trace[80294883] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"150.533002ms","start":"2026-03-17T22:01:01.36072Z","end":"2026-03-17T22:01:01.511253Z","steps":["trace[80294883] 'process raft request'  (duration: 150.312826ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:08.46837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.85145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-17T22:01:08.468507Z","caller":"traceutil/trace.go:171","msg":"trace[2134454712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"204.076427ms","start":"2026-03-17T22:01:08.264403Z","end":"2026-03-17T22:01:08.468479Z","steps":["trace[2134454712] 'range keys from in-memory index tree'  (duration: 202.980656ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:08.659111Z","caller":"traceutil/trace.go:171","msg":"trace[1818994378] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"103.643973ms","start":"2026-03-17T22:01:08.555426Z","end":"2026-03-17T22:01:08.65907Z","steps":["trace[1818994378] 'process raft request'  (duration: 33.144859ms)","trace[1818994378] 'compare'  (duration: 70.325489ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:09.264761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.604512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:09.264854Z","caller":"traceutil/trace.go:171","msg":"trace[1166126137] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:554; }","duration":"367.827767ms","start":"2026-03-17T22:01:08.897003Z","end":"2026-03-17T22:01:09.264831Z","steps":["trace[1166126137] 'range keys from in-memory index tree'  (duration: 367.473017ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:09.264895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:08.896973Z","time spent":"367.91349ms","remote":"127.0.0.1:35474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" "}
{"level":"warn","ts":"2026-03-17T22:01:09.264857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.24257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:09.26501Z","caller":"traceutil/trace.go:171","msg":"trace[1207689698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"205.450686ms","start":"2026-03-17T22:01:09.059501Z","end":"2026-03-17T22:01:09.264951Z","steps":["trace[1207689698] 'range keys from in-memory index tree'  (duration: 205.043694ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:10.891127Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.0706464s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-17T22:01:10.891673Z","caller":"traceutil/trace.go:171","msg":"trace[316197530] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"399.32714ms","start":"2026-03-17T22:01:10.492313Z","end":"2026-03-17T22:01:10.89164Z","steps":["trace[316197530] 'read index received'  (duration: 399.120734ms)","trace[316197530] 'applied index is now lower than readState.Index'  (duration: 204.896µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:10.891759Z","caller":"traceutil/trace.go:171","msg":"trace[1882966179] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"1.071391479s","start":"2026-03-17T22:01:09.820332Z","end":"2026-03-17T22:01:10.891723Z","steps":["trace[1882966179] 'process raft request'  (duration: 1.071126452s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:10.891945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:09.820285Z","time spent":"1.071560185s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-17T22:01:10.892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.662769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-17T22:01:10.892052Z","caller":"traceutil/trace.go:171","msg":"trace[1306608181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"399.783712ms","start":"2026-03-17T22:01:10.492254Z","end":"2026-03-17T22:01:10.892037Z","steps":["trace[1306608181] 'agreement among raft nodes before linearized reading'  (duration: 399.575786ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:10.892096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:10.492232Z","time spent":"399.854724ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-17T22:01:10.89229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.387795ms","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-03-17T22:01:10.89252Z","caller":"traceutil/trace.go:171","msg":"trace[1679751243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"336.667853ms","start":"2026-03-17T22:01:10.555837Z","end":"2026-03-17T22:01:10.892505Z","steps":["trace[1679751243] 'agreement among raft nodes before linearized reading'  (duration: 336.251962ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:10.892558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:10.555809Z","time spent":"336.738845ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-17T22:01:10.892811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.757691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-17T22:01:10.892834Z","caller":"traceutil/trace.go:171","msg":"trace[465616733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"228.831564ms","start":"2026-03-17T22:01:10.663994Z","end":"2026-03-17T22:01:10.892826Z","steps":["trace[465616733] 'agreement among raft nodes before linearized reading'  (duration: 228.713091ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:11.559099Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2594527474281481403,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-17T22:01:11.929434Z","caller":"traceutil/trace.go:171","msg":"trace[383043822] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.03210287s","start":"2026-03-17T22:01:10.897293Z","end":"2026-03-17T22:01:11.929396Z","steps":["trace[383043822] 'process raft request'  (duration: 940.81712ms)","trace[383043822] 'compare'  (duration: 90.835317ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:11.929637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:10.897264Z","time spent":"1.032259974s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-17T22:01:11.952513Z","caller":"traceutil/trace.go:171","msg":"trace[1927816720] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.054590864s","start":"2026-03-17T22:01:10.89789Z","end":"2026-03-17T22:01:11.95248Z","steps":["trace[1927816720] 'process raft request'  (duration: 1.054505972s)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:11.952515Z","caller":"traceutil/trace.go:171","msg":"trace[1507887577] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.054769718s","start":"2026-03-17T22:01:10.897717Z","end":"2026-03-17T22:01:11.952487Z","steps":["trace[1507887577] 'process raft request'  (duration: 1.054531852s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:11.952736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:10.89769Z","time spent":"1.054946293s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:554 > 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\" > >"}
{"level":"warn","ts":"2026-03-17T22:01:11.952736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:10.897882Z","time spent":"1.054751538s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:553 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-17T22:01:11.952797Z","caller":"traceutil/trace.go:171","msg":"trace[1037887650] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"191.900019ms","start":"2026-03-17T22:01:11.760881Z","end":"2026-03-17T22:01:11.952781Z","steps":["trace[1037887650] 'process raft request'  (duration: 191.55719ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:11.953223Z","caller":"traceutil/trace.go:171","msg":"trace[1226364936] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:571; }","duration":"894.492865ms","start":"2026-03-17T22:01:11.058649Z","end":"2026-03-17T22:01:11.953142Z","steps":["trace[1226364936] 'read index received'  (duration: 779.479497ms)","trace[1226364936] 'applied index is now lower than readState.Index'  (duration: 115.009858ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:11.953326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.678081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:11.953399Z","caller":"traceutil/trace.go:171","msg":"trace[1528397226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"894.802024ms","start":"2026-03-17T22:01:11.058575Z","end":"2026-03-17T22:01:11.953377Z","steps":["trace[1528397226] 'agreement among raft nodes before linearized reading'  (duration: 894.682151ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:11.953442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:11.058546Z","time spent":"894.888677ms","remote":"127.0.0.1:35366","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-03-17T22:01:12.841436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.46603ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281481499 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/cert-manager-controller-clusterissuers\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/cert-manager-controller-clusterissuers\" value_size:1087 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:01:12.841688Z","caller":"traceutil/trace.go:171","msg":"trace[329433589] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"221.966524ms","start":"2026-03-17T22:01:12.619687Z","end":"2026-03-17T22:01:12.841653Z","steps":["trace[329433589] 'process raft request'  (duration: 44.184425ms)","trace[329433589] 'compare'  (duration: 177.260574ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:12.841816Z","caller":"traceutil/trace.go:171","msg":"trace[787209227] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"221.980934ms","start":"2026-03-17T22:01:12.619792Z","end":"2026-03-17T22:01:12.841773Z","steps":["trace[787209227] 'process raft request'  (duration: 221.792319ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842075Z","caller":"traceutil/trace.go:171","msg":"trace[450663489] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"222.157109ms","start":"2026-03-17T22:01:12.619903Z","end":"2026-03-17T22:01:12.84206Z","steps":["trace[450663489] 'process raft request'  (duration: 221.892611ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842188Z","caller":"traceutil/trace.go:171","msg":"trace[505486504] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"222.240831ms","start":"2026-03-17T22:01:12.619928Z","end":"2026-03-17T22:01:12.842169Z","steps":["trace[505486504] 'process raft request'  (duration: 221.896211ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842186Z","caller":"traceutil/trace.go:171","msg":"trace[934077578] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"222.183849ms","start":"2026-03-17T22:01:12.619962Z","end":"2026-03-17T22:01:12.842146Z","steps":["trace[934077578] 'process raft request'  (duration: 221.889121ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842241Z","caller":"traceutil/trace.go:171","msg":"trace[1819242880] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"222.234141ms","start":"2026-03-17T22:01:12.619992Z","end":"2026-03-17T22:01:12.842226Z","steps":["trace[1819242880] 'process raft request'  (duration: 221.891232ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842329Z","caller":"traceutil/trace.go:171","msg":"trace[68508085] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"222.473298ms","start":"2026-03-17T22:01:12.619841Z","end":"2026-03-17T22:01:12.842315Z","steps":["trace[68508085] 'process raft request'  (duration: 221.788619ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842386Z","caller":"traceutil/trace.go:171","msg":"trace[1503116032] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"222.507938ms","start":"2026-03-17T22:01:12.619852Z","end":"2026-03-17T22:01:12.84236Z","steps":["trace[1503116032] 'process raft request'  (duration: 221.909231ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.842599Z","caller":"traceutil/trace.go:171","msg":"trace[1501358339] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"222.562901ms","start":"2026-03-17T22:01:12.620028Z","end":"2026-03-17T22:01:12.842591Z","steps":["trace[1501358339] 'process raft request'  (duration: 221.885292ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.843006Z","caller":"traceutil/trace.go:171","msg":"trace[344928511] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"222.733945ms","start":"2026-03-17T22:01:12.620247Z","end":"2026-03-17T22:01:12.842981Z","steps":["trace[344928511] 'process raft request'  (duration: 221.699757ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.843058Z","caller":"traceutil/trace.go:171","msg":"trace[458093128] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"222.718674ms","start":"2026-03-17T22:01:12.620323Z","end":"2026-03-17T22:01:12.843042Z","steps":["trace[458093128] 'process raft request'  (duration: 222.536109ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.843119Z","caller":"traceutil/trace.go:171","msg":"trace[1981473396] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"219.155456ms","start":"2026-03-17T22:01:12.623949Z","end":"2026-03-17T22:01:12.843104Z","steps":["trace[1981473396] 'process raft request'  (duration: 219.012222ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.843193Z","caller":"traceutil/trace.go:171","msg":"trace[1376510269] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"217.540421ms","start":"2026-03-17T22:01:12.625643Z","end":"2026-03-17T22:01:12.843184Z","steps":["trace[1376510269] 'process raft request'  (duration: 217.380656ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.843216Z","caller":"traceutil/trace.go:171","msg":"trace[1311688157] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"183.899588ms","start":"2026-03-17T22:01:12.659289Z","end":"2026-03-17T22:01:12.843188Z","steps":["trace[1311688157] 'process raft request'  (duration: 183.858637ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:12.843263Z","caller":"traceutil/trace.go:171","msg":"trace[1392263149] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"217.386147ms","start":"2026-03-17T22:01:12.625869Z","end":"2026-03-17T22:01:12.843255Z","steps":["trace[1392263149] 'process raft request'  (duration: 217.226302ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.189753Z","caller":"traceutil/trace.go:171","msg":"trace[1432476688] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"153.585888ms","start":"2026-03-17T22:01:13.036048Z","end":"2026-03-17T22:01:13.189634Z","steps":["trace[1432476688] 'process raft request'  (duration: 77.115098ms)","trace[1432476688] 'compare'  (duration: 76.1196ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:13.190059Z","caller":"traceutil/trace.go:171","msg":"trace[1222402503] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"127.737361ms","start":"2026-03-17T22:01:13.062298Z","end":"2026-03-17T22:01:13.190035Z","steps":["trace[1222402503] 'read index received'  (duration: 50.922931ms)","trace[1222402503] 'applied index is now lower than readState.Index'  (duration: 76.81338ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:13.190173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.863905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:13.1902Z","caller":"traceutil/trace.go:171","msg":"trace[1866104727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"127.941007ms","start":"2026-03-17T22:01:13.062251Z","end":"2026-03-17T22:01:13.190192Z","steps":["trace[1866104727] 'agreement among raft nodes before linearized reading'  (duration: 127.874375ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.190363Z","caller":"traceutil/trace.go:171","msg":"trace[1421560979] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"130.356864ms","start":"2026-03-17T22:01:13.059936Z","end":"2026-03-17T22:01:13.190293Z","steps":["trace[1421560979] 'process raft request'  (duration: 129.887031ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.354028Z","caller":"traceutil/trace.go:171","msg":"trace[644326666] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"122.152486ms","start":"2026-03-17T22:01:13.231859Z","end":"2026-03-17T22:01:13.354012Z","steps":["trace[644326666] 'process raft request'  (duration: 122.105815ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.354096Z","caller":"traceutil/trace.go:171","msg":"trace[1669546385] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"139.498387ms","start":"2026-03-17T22:01:13.214563Z","end":"2026-03-17T22:01:13.354061Z","steps":["trace[1669546385] 'process raft request'  (duration: 139.170847ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.354021Z","caller":"traceutil/trace.go:171","msg":"trace[918503858] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"138.423427ms","start":"2026-03-17T22:01:13.215562Z","end":"2026-03-17T22:01:13.353985Z","steps":["trace[918503858] 'process raft request'  (duration: 138.215092ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.354322Z","caller":"traceutil/trace.go:171","msg":"trace[315611970] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"139.822226ms","start":"2026-03-17T22:01:13.21447Z","end":"2026-03-17T22:01:13.354292Z","steps":["trace[315611970] 'process raft request'  (duration: 90.439387ms)","trace[315611970] 'compare'  (duration: 48.625708ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:13.354309Z","caller":"traceutil/trace.go:171","msg":"trace[1335869222] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"130.517678ms","start":"2026-03-17T22:01:13.223741Z","end":"2026-03-17T22:01:13.354259Z","steps":["trace[1335869222] 'process raft request'  (duration: 130.110087ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.537312Z","caller":"traceutil/trace.go:171","msg":"trace[1514391246] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"106.626235ms","start":"2026-03-17T22:01:13.430653Z","end":"2026-03-17T22:01:13.537279Z","steps":["trace[1514391246] 'process raft request'  (duration: 106.353748ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.537398Z","caller":"traceutil/trace.go:171","msg":"trace[2020237621] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"106.658106ms","start":"2026-03-17T22:01:13.430695Z","end":"2026-03-17T22:01:13.537353Z","steps":["trace[2020237621] 'process raft request'  (duration: 106.489202ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.537525Z","caller":"traceutil/trace.go:171","msg":"trace[344546332] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"105.182675ms","start":"2026-03-17T22:01:13.432311Z","end":"2026-03-17T22:01:13.537494Z","steps":["trace[344546332] 'process raft request'  (duration: 104.929818ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.538011Z","caller":"traceutil/trace.go:171","msg":"trace[1794093134] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"104.053264ms","start":"2026-03-17T22:01:13.433945Z","end":"2026-03-17T22:01:13.537999Z","steps":["trace[1794093134] 'process raft request'  (duration: 103.504799ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.53762Z","caller":"traceutil/trace.go:171","msg":"trace[530424543] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"105.126115ms","start":"2026-03-17T22:01:13.432483Z","end":"2026-03-17T22:01:13.53761Z","steps":["trace[530424543] 'process raft request'  (duration: 104.841017ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.537626Z","caller":"traceutil/trace.go:171","msg":"trace[1208848017] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"104.901817ms","start":"2026-03-17T22:01:13.432706Z","end":"2026-03-17T22:01:13.537608Z","steps":["trace[1208848017] 'process raft request'  (duration: 104.687502ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.538704Z","caller":"traceutil/trace.go:171","msg":"trace[1556251613] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"103.842809ms","start":"2026-03-17T22:01:13.434848Z","end":"2026-03-17T22:01:13.53869Z","steps":["trace[1556251613] 'process raft request'  (duration: 103.086468ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.538834Z","caller":"traceutil/trace.go:171","msg":"trace[1363997680] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"108.060236ms","start":"2026-03-17T22:01:13.430752Z","end":"2026-03-17T22:01:13.538812Z","steps":["trace[1363997680] 'read index received'  (duration: 18.827252ms)","trace[1363997680] 'applied index is now lower than readState.Index'  (duration: 89.231794ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:13.539002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.23515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:4640"}
{"level":"info","ts":"2026-03-17T22:01:13.539908Z","caller":"traceutil/trace.go:171","msg":"trace[741180399] range","detail":"{range_begin:/registry/deployments/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:658; }","duration":"109.174937ms","start":"2026-03-17T22:01:13.430714Z","end":"2026-03-17T22:01:13.539889Z","steps":["trace[741180399] 'agreement among raft nodes before linearized reading'  (duration: 108.160609ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.539036Z","caller":"traceutil/trace.go:171","msg":"trace[1306221813] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"104.039094ms","start":"2026-03-17T22:01:13.434955Z","end":"2026-03-17T22:01:13.538994Z","steps":["trace[1306221813] 'process raft request'  (duration: 103.672624ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:13.558385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.369956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-startupapicheck\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:13.55849Z","caller":"traceutil/trace.go:171","msg":"trace[1984433862] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-startupapicheck; range_end:; response_count:0; response_revision:659; }","duration":"120.530861ms","start":"2026-03-17T22:01:13.437936Z","end":"2026-03-17T22:01:13.558467Z","steps":["trace[1984433862] 'agreement among raft nodes before linearized reading'  (duration: 120.354567ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.686983Z","caller":"traceutil/trace.go:171","msg":"trace[1686468220] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"112.329404ms","start":"2026-03-17T22:01:13.574615Z","end":"2026-03-17T22:01:13.686945Z","steps":["trace[1686468220] 'process raft request'  (duration: 105.824094ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:13.687058Z","caller":"traceutil/trace.go:171","msg":"trace[1579420693] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"112.316323ms","start":"2026-03-17T22:01:13.57471Z","end":"2026-03-17T22:01:13.687026Z","steps":["trace[1579420693] 'process raft request'  (duration: 112.157859ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:14.005826Z","caller":"traceutil/trace.go:171","msg":"trace[1129179230] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"199.908251ms","start":"2026-03-17T22:01:13.805877Z","end":"2026-03-17T22:01:14.005785Z","steps":["trace[1129179230] 'process raft request'  (duration: 199.706106ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:14.086274Z","caller":"traceutil/trace.go:171","msg":"trace[133238235] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"152.23433ms","start":"2026-03-17T22:01:13.934015Z","end":"2026-03-17T22:01:14.086249Z","steps":["trace[133238235] 'read index received'  (duration: 71.827651ms)","trace[133238235] 'applied index is now lower than readState.Index'  (duration: 80.405459ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:14.086513Z","caller":"traceutil/trace.go:171","msg":"trace[2093555534] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"248.874719ms","start":"2026-03-17T22:01:13.83748Z","end":"2026-03-17T22:01:14.086355Z","steps":["trace[2093555534] 'process raft request'  (duration: 248.457547ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:14.086674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.323113ms","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-03-17T22:01:14.086722Z","caller":"traceutil/trace.go:171","msg":"trace[1987544218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:681; }","duration":"130.444656ms","start":"2026-03-17T22:01:13.956264Z","end":"2026-03-17T22:01:14.086709Z","steps":["trace[1987544218] 'agreement among raft nodes before linearized reading'  (duration: 130.207459ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:14.086711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.670893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-17T22:01:14.086812Z","caller":"traceutil/trace.go:171","msg":"trace[241873261] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:681; }","duration":"152.851167ms","start":"2026-03-17T22:01:13.933933Z","end":"2026-03-17T22:01:14.086784Z","steps":["trace[241873261] 'agreement among raft nodes before linearized reading'  (duration: 152.471256ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:14.087092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.683133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-17T22:01:14.087239Z","caller":"traceutil/trace.go:171","msg":"trace[81482145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:681; }","duration":"130.969761ms","start":"2026-03-17T22:01:13.956245Z","end":"2026-03-17T22:01:14.087215Z","steps":["trace[81482145] 'agreement among raft nodes before linearized reading'  (duration: 130.306232ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:31.985286Z","caller":"traceutil/trace.go:171","msg":"trace[996996361] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"270.88544ms","start":"2026-03-17T22:01:31.714353Z","end":"2026-03-17T22:01:31.985239Z","steps":["trace[996996361] 'process raft request'  (duration: 199.043888ms)","trace[996996361] 'compare'  (duration: 71.654596ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:56.413989Z","caller":"traceutil/trace.go:171","msg":"trace[224742935] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"124.202696ms","start":"2026-03-17T22:01:56.289754Z","end":"2026-03-17T22:01:56.413956Z","steps":["trace[224742935] 'process raft request'  (duration: 124.006891ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:29.595129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.688622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T22:02:29.595243Z","caller":"traceutil/trace.go:171","msg":"trace[375749089] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1628; }","duration":"129.831825ms","start":"2026-03-17T22:02:29.465387Z","end":"2026-03-17T22:02:29.595219Z","steps":["trace[375749089] 'range keys from in-memory index tree'  (duration: 129.430035ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:29.878218Z","caller":"traceutil/trace.go:171","msg":"trace[221565304] linearizableReadLoop","detail":"{readStateIndex:1688; appliedIndex:1687; }","duration":"272.85371ms","start":"2026-03-17T22:02:29.60534Z","end":"2026-03-17T22:02:29.878193Z","steps":["trace[221565304] 'read index received'  (duration: 272.711026ms)","trace[221565304] 'applied index is now lower than readState.Index'  (duration: 141.264µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:02:29.878304Z","caller":"traceutil/trace.go:171","msg":"trace[827200907] transaction","detail":"{read_only:false; response_revision:1629; number_of_response:1; }","duration":"278.100999ms","start":"2026-03-17T22:02:29.600156Z","end":"2026-03-17T22:02:29.878257Z","steps":["trace[827200907] 'process raft request'  (duration: 277.859102ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:29.87864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.258321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8293fbd-01f4-4ec2-ab19-b580fe7e9a4b\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-03-17T22:02:29.878773Z","caller":"traceutil/trace.go:171","msg":"trace[842778486] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a8293fbd-01f4-4ec2-ab19-b580fe7e9a4b; range_end:; response_count:1; response_revision:1629; }","duration":"273.437685ms","start":"2026-03-17T22:02:29.605296Z","end":"2026-03-17T22:02:29.878733Z","steps":["trace[842778486] 'agreement among raft nodes before linearized reading'  (duration: 272.985294ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:30.443357Z","caller":"traceutil/trace.go:171","msg":"trace[1949339414] transaction","detail":"{read_only:false; response_revision:1630; number_of_response:1; }","duration":"456.702399ms","start":"2026-03-17T22:02:29.986612Z","end":"2026-03-17T22:02:30.443314Z","steps":["trace[1949339414] 'process raft request'  (duration: 456.308748ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:30.44339Z","caller":"traceutil/trace.go:171","msg":"trace[2079130390] linearizableReadLoop","detail":"{readStateIndex:1689; appliedIndex:1688; }","duration":"401.529124ms","start":"2026-03-17T22:02:30.041661Z","end":"2026-03-17T22:02:30.44319Z","steps":["trace[2079130390] 'read index received'  (duration: 401.341699ms)","trace[2079130390] 'applied index is now lower than readState.Index'  (duration: 185.445µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:02:30.443564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:02:29.986574Z","time spent":"456.874573ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8293fbd-01f4-4ec2-ab19-b580fe7e9a4b\" mod_revision:1591 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8293fbd-01f4-4ec2-ab19-b580fe7e9a4b\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a8293fbd-01f4-4ec2-ab19-b580fe7e9a4b\" > >"}
{"level":"warn","ts":"2026-03-17T22:02:30.443649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.957516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-17T22:02:30.443741Z","caller":"traceutil/trace.go:171","msg":"trace[285377645] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1630; }","duration":"402.11455ms","start":"2026-03-17T22:02:30.041601Z","end":"2026-03-17T22:02:30.443715Z","steps":["trace[285377645] 'agreement among raft nodes before linearized reading'  (duration: 401.809142ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:30.443787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:02:30.041575Z","time spent":"402.203463ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-03-17T22:02:30.469712Z","caller":"traceutil/trace.go:171","msg":"trace[898520187] transaction","detail":"{read_only:false; response_revision:1631; number_of_response:1; }","duration":"181.523807ms","start":"2026-03-17T22:02:30.288156Z","end":"2026-03-17T22:02:30.46968Z","steps":["trace[898520187] 'process raft request'  (duration: 181.316042ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:30.469779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.77232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:02:30.470238Z","caller":"traceutil/trace.go:171","msg":"trace[759022304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1631; }","duration":"411.266043ms","start":"2026-03-17T22:02:30.058955Z","end":"2026-03-17T22:02:30.470221Z","steps":["trace[759022304] 'agreement among raft nodes before linearized reading'  (duration: 410.694488ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:30.470346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:02:30.058944Z","time spent":"411.371306ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-17T22:02:38.878233Z","caller":"traceutil/trace.go:171","msg":"trace[1822400828] transaction","detail":"{read_only:false; response_revision:1710; number_of_response:1; }","duration":"153.640957ms","start":"2026-03-17T22:02:38.724558Z","end":"2026-03-17T22:02:38.878199Z","steps":["trace[1822400828] 'process raft request'  (duration: 153.429191ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:38.973431Z","caller":"traceutil/trace.go:171","msg":"trace[1841971983] linearizableReadLoop","detail":"{readStateIndex:1774; appliedIndex:1772; }","duration":"228.063121ms","start":"2026-03-17T22:02:38.745331Z","end":"2026-03-17T22:02:38.973394Z","steps":["trace[1841971983] 'read index received'  (duration: 132.716212ms)","trace[1841971983] 'applied index is now lower than readState.Index'  (duration: 95.345609ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:02:38.973654Z","caller":"traceutil/trace.go:171","msg":"trace[991908464] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"249.027438ms","start":"2026-03-17T22:02:38.724592Z","end":"2026-03-17T22:02:38.973619Z","steps":["trace[991908464] 'process raft request'  (duration: 238.693594ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:38.973886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.531604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-17T22:02:38.974003Z","caller":"traceutil/trace.go:171","msg":"trace[259408278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1711; }","duration":"228.738ms","start":"2026-03-17T22:02:38.745239Z","end":"2026-03-17T22:02:38.973977Z","steps":["trace[259408278] 'agreement among raft nodes before linearized reading'  (duration: 228.398421ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:39.024607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.975176ms","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-03-17T22:02:39.024716Z","caller":"traceutil/trace.go:171","msg":"trace[942910641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1712; }","duration":"278.12782ms","start":"2026-03-17T22:02:38.746563Z","end":"2026-03-17T22:02:39.024691Z","steps":["trace[942910641] 'agreement among raft nodes before linearized reading'  (duration: 277.796071ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:44.860497Z","caller":"traceutil/trace.go:171","msg":"trace[898169543] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"160.418607ms","start":"2026-03-17T22:02:44.700038Z","end":"2026-03-17T22:02:44.860456Z","steps":["trace[898169543] 'process raft request'  (duration: 154.274004ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:46.273983Z","caller":"traceutil/trace.go:171","msg":"trace[275068152] linearizableReadLoop","detail":"{readStateIndex:1824; appliedIndex:1823; }","duration":"214.727178ms","start":"2026-03-17T22:02:46.059226Z","end":"2026-03-17T22:02:46.273953Z","steps":["trace[275068152] 'read index received'  (duration: 214.530472ms)","trace[275068152] 'applied index is now lower than readState.Index'  (duration: 195.145µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:02:46.274049Z","caller":"traceutil/trace.go:171","msg":"trace[1165820814] transaction","detail":"{read_only:false; response_revision:1760; number_of_response:1; }","duration":"286.550744ms","start":"2026-03-17T22:02:45.987449Z","end":"2026-03-17T22:02:46.274Z","steps":["trace[1165820814] 'process raft request'  (duration: 286.331988ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:46.274204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.948164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:02:46.274324Z","caller":"traceutil/trace.go:171","msg":"trace[294445681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1760; }","duration":"215.092808ms","start":"2026-03-17T22:02:46.059204Z","end":"2026-03-17T22:02:46.274297Z","steps":["trace[294445681] 'agreement among raft nodes before linearized reading'  (duration: 214.883822ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:52.845137Z","caller":"traceutil/trace.go:171","msg":"trace[1730277146] linearizableReadLoop","detail":"{readStateIndex:1855; appliedIndex:1853; }","duration":"139.951334ms","start":"2026-03-17T22:02:52.705142Z","end":"2026-03-17T22:02:52.845093Z","steps":["trace[1730277146] 'read index received'  (duration: 55.894043ms)","trace[1730277146] 'applied index is now lower than readState.Index'  (duration: 84.055811ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:02:52.845202Z","caller":"traceutil/trace.go:171","msg":"trace[1070175665] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"147.706679ms","start":"2026-03-17T22:02:52.697461Z","end":"2026-03-17T22:02:52.845167Z","steps":["trace[1070175665] 'process raft request'  (duration: 146.358483ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:52.845422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.266102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-17T22:02:52.845485Z","caller":"traceutil/trace.go:171","msg":"trace[747227034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1789; }","duration":"140.395696ms","start":"2026-03-17T22:02:52.705071Z","end":"2026-03-17T22:02:52.845467Z","steps":["trace[747227034] 'agreement among raft nodes before linearized reading'  (duration: 140.18798ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:09.550561Z","caller":"traceutil/trace.go:171","msg":"trace[1736420117] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"115.654981ms","start":"2026-03-17T22:03:09.434865Z","end":"2026-03-17T22:03:09.55052Z","steps":["trace[1736420117] 'process raft request'  (duration: 107.210054ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:15.395846Z","caller":"traceutil/trace.go:171","msg":"trace[905333626] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"523.393312ms","start":"2026-03-17T22:03:14.872411Z","end":"2026-03-17T22:03:15.395805Z","steps":["trace[905333626] 'process raft request'  (duration: 523.184176ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.396096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:14.872375Z","time spent":"523.592877ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1899 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-03-17T22:03:15.653658Z","caller":"traceutil/trace.go:171","msg":"trace[816029408] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"711.835471ms","start":"2026-03-17T22:03:14.941784Z","end":"2026-03-17T22:03:15.65362Z","steps":["trace[816029408] 'process raft request'  (duration: 696.847137ms)","trace[816029408] 'compare'  (duration: 14.740357ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:03:15.653863Z","caller":"traceutil/trace.go:171","msg":"trace[254365379] linearizableReadLoop","detail":"{readStateIndex:1981; appliedIndex:1979; }","duration":"635.59123ms","start":"2026-03-17T22:03:15.018226Z","end":"2026-03-17T22:03:15.653817Z","steps":["trace[254365379] 'read index received'  (duration: 377.386413ms)","trace[254365379] 'applied index is now lower than readState.Index'  (duration: 258.198267ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:03:15.653941Z","caller":"traceutil/trace.go:171","msg":"trace[1621210774] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"493.938859ms","start":"2026-03-17T22:03:15.159955Z","end":"2026-03-17T22:03:15.653893Z","steps":["trace[1621210774] 'process raft request'  (duration: 493.61664ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.653927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:14.941756Z","time spent":"712.027486ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1900 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-17T22:03:15.654143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.924789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-03-17T22:03:15.654167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:15.159926Z","time spent":"494.125333ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1902 > 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-03-17T22:03:15.654201Z","caller":"traceutil/trace.go:171","msg":"trace[1883020538] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1912; }","duration":"636.033432ms","start":"2026-03-17T22:03:15.018153Z","end":"2026-03-17T22:03:15.654187Z","steps":["trace[1883020538] 'agreement among raft nodes before linearized reading'  (duration: 635.842187ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.654196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.443173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:03:15.654237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:15.018123Z","time spent":"636.107043ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-03-17T22:03:15.654282Z","caller":"traceutil/trace.go:171","msg":"trace[866003105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1912; }","duration":"594.573367ms","start":"2026-03-17T22:03:15.059666Z","end":"2026-03-17T22:03:15.65424Z","steps":["trace[866003105] 'agreement among raft nodes before linearized reading'  (duration: 594.419992ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.654349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:15.059647Z","time spent":"594.686879ms","remote":"127.0.0.1:35364","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-03-17T22:03:15.654376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.62283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-17T22:03:15.654537Z","caller":"traceutil/trace.go:171","msg":"trace[1720324535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1912; }","duration":"406.805935ms","start":"2026-03-17T22:03:15.247668Z","end":"2026-03-17T22:03:15.654474Z","steps":["trace[1720324535] 'agreement among raft nodes before linearized reading'  (duration: 406.505257ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.654615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:15.247638Z","time spent":"406.960159ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-17T22:03:15.654629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.38144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-17T22:03:15.654678Z","caller":"traceutil/trace.go:171","msg":"trace[1831510953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1912; }","duration":"462.477702ms","start":"2026-03-17T22:03:15.192188Z","end":"2026-03-17T22:03:15.654665Z","steps":["trace[1831510953] 'agreement among raft nodes before linearized reading'  (duration: 462.184144ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.654713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:15.192161Z","time spent":"462.545734ms","remote":"127.0.0.1:35660","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":"warn","ts":"2026-03-17T22:03:15.654747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.14578ms","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-03-17T22:03:15.654834Z","caller":"traceutil/trace.go:171","msg":"trace[142790636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1912; }","duration":"250.299894ms","start":"2026-03-17T22:03:15.404511Z","end":"2026-03-17T22:03:15.654811Z","steps":["trace[142790636] 'agreement among raft nodes before linearized reading'  (duration: 250.092028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.654843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.579219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-17T22:03:15.654893Z","caller":"traceutil/trace.go:171","msg":"trace[297275271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1912; }","duration":"551.663932ms","start":"2026-03-17T22:03:15.103215Z","end":"2026-03-17T22:03:15.654878Z","steps":["trace[297275271] 'agreement among raft nodes before linearized reading'  (duration: 551.512758ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:15.654947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:15.103195Z","time spent":"551.740474ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-17T22:03:15.843695Z","caller":"traceutil/trace.go:171","msg":"trace[2011919794] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"183.736883ms","start":"2026-03-17T22:03:15.659911Z","end":"2026-03-17T22:03:15.843647Z","steps":["trace[2011919794] 'process raft request'  (duration: 100.206656ms)","trace[2011919794] 'compare'  (duration: 83.297401ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:03:15.843965Z","caller":"traceutil/trace.go:171","msg":"trace[1029522774] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"183.920018ms","start":"2026-03-17T22:03:15.660013Z","end":"2026-03-17T22:03:15.843933Z","steps":["trace[1029522774] 'process raft request'  (duration: 183.812505ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:15.84396Z","caller":"traceutil/trace.go:171","msg":"trace[1152632396] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"183.970549ms","start":"2026-03-17T22:03:15.659947Z","end":"2026-03-17T22:03:15.843917Z","steps":["trace[1152632396] 'process raft request'  (duration: 183.647681ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:23.036055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2594527474281484209,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-17T22:03:23.068692Z","caller":"traceutil/trace.go:171","msg":"trace[533277079] linearizableReadLoop","detail":"{readStateIndex:2015; appliedIndex:2014; }","duration":"533.202276ms","start":"2026-03-17T22:03:22.535464Z","end":"2026-03-17T22:03:23.068667Z","steps":["trace[533277079] 'read index received'  (duration: 533.009801ms)","trace[533277079] 'applied index is now lower than readState.Index'  (duration: 191.085µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:03:23.068708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:22.426829Z","time spent":"641.87146ms","remote":"127.0.0.1:35414","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-17T22:03:23.068881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.391092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:03:23.068955Z","caller":"traceutil/trace.go:171","msg":"trace[47525456] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1943; }","duration":"533.533825ms","start":"2026-03-17T22:03:22.535398Z","end":"2026-03-17T22:03:23.068932Z","steps":["trace[47525456] 'agreement among raft nodes before linearized reading'  (duration: 533.380281ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:23.068996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:22.535372Z","time spent":"533.614998ms","remote":"127.0.0.1:35636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:03:23.069091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.762996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-03-17T22:03:23.069092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.37516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T22:03:23.069152Z","caller":"traceutil/trace.go:171","msg":"trace[150519317] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1943; }","duration":"328.890919ms","start":"2026-03-17T22:03:22.740244Z","end":"2026-03-17T22:03:23.069135Z","steps":["trace[150519317] 'agreement among raft nodes before linearized reading'  (duration: 328.685873ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:23.069175Z","caller":"traceutil/trace.go:171","msg":"trace[1109351581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1943; }","duration":"514.480583ms","start":"2026-03-17T22:03:22.554673Z","end":"2026-03-17T22:03:23.069153Z","steps":["trace[1109351581] 'agreement among raft nodes before linearized reading'  (duration: 514.197136ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:23.0692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:22.740214Z","time spent":"328.976941ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-03-17T22:03:23.069216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:22.554625Z","time spent":"514.583786ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-17T22:03:23.682082Z","caller":"traceutil/trace.go:171","msg":"trace[1141341771] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"255.789551ms","start":"2026-03-17T22:03:23.426249Z","end":"2026-03-17T22:03:23.682038Z","steps":["trace[1141341771] 'process raft request'  (duration: 170.698612ms)","trace[1141341771] 'compare'  (duration: 84.782581ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:03:24.578316Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2594527474281484232,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:03:24.973791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104838911s","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-03-17T22:03:24.973877Z","caller":"traceutil/trace.go:171","msg":"trace[684561262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1949; }","duration":"1.104986655s","start":"2026-03-17T22:03:23.868871Z","end":"2026-03-17T22:03:24.973858Z","steps":["trace[684561262] 'range keys from in-memory index tree'  (duration: 1.104626935s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:24.97392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:23.868841Z","time spent":"1.105069857s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-17T22:03:24.973912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078515553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-17T22:03:24.974176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087256428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-17T22:03:24.974398Z","caller":"traceutil/trace.go:171","msg":"trace[1083846513] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"911.003716ms","start":"2026-03-17T22:03:24.063375Z","end":"2026-03-17T22:03:24.974378Z","steps":["trace[1083846513] 'process raft request'  (duration: 869.953971ms)","trace[1083846513] 'compare'  (duration: 40.300695ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:03:24.974236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079465778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-17T22:03:24.974388Z","caller":"traceutil/trace.go:171","msg":"trace[86768370] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1949; }","duration":"1.087590217s","start":"2026-03-17T22:03:23.886766Z","end":"2026-03-17T22:03:24.974357Z","steps":["trace[86768370] 'range keys from in-memory index tree'  (duration: 1.087010482s)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:24.974532Z","caller":"traceutil/trace.go:171","msg":"trace[764590665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1949; }","duration":"1.079824558s","start":"2026-03-17T22:03:23.894681Z","end":"2026-03-17T22:03:24.974505Z","steps":["trace[764590665] 'range keys from in-memory index tree'  (duration: 1.079205861s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:24.974542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.063341Z","time spent":"911.124929ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1908 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-03-17T22:03:24.973999Z","caller":"traceutil/trace.go:171","msg":"trace[1030222004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1949; }","duration":"1.078633906s","start":"2026-03-17T22:03:23.895343Z","end":"2026-03-17T22:03:24.973977Z","steps":["trace[1030222004] 'range keys from in-memory index tree'  (duration: 1.078355379s)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:24.974546Z","caller":"traceutil/trace.go:171","msg":"trace[621413700] linearizableReadLoop","detail":"{readStateIndex:2023; appliedIndex:2021; }","duration":"896.354612ms","start":"2026-03-17T22:03:24.078164Z","end":"2026-03-17T22:03:24.974519Z","steps":["trace[621413700] 'read index received'  (duration: 855.178654ms)","trace[621413700] 'applied index is now lower than readState.Index'  (duration: 41.175048ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:03:24.974641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:23.894662Z","time spent":"1.07992304s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-17T22:03:24.97464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:23.895335Z","time spent":"1.079286153s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-17T22:03:24.974639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:23.886739Z","time spent":"1.087797132s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T22:03:24.974743Z","caller":"traceutil/trace.go:171","msg":"trace[1236501557] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"406.425552ms","start":"2026-03-17T22:03:24.568301Z","end":"2026-03-17T22:03:24.974726Z","steps":["trace[1236501557] 'process raft request'  (duration: 406.069133ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:24.974794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.64758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-03-17T22:03:24.974822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.568268Z","time spent":"406.501474ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1918 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-03-17T22:03:24.974838Z","caller":"traceutil/trace.go:171","msg":"trace[1235483985] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1951; }","duration":"896.738053ms","start":"2026-03-17T22:03:24.078084Z","end":"2026-03-17T22:03:24.974822Z","steps":["trace[1235483985] 'agreement among raft nodes before linearized reading'  (duration: 896.571688ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:24.974873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.078055Z","time spent":"896.810744ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-03-17T22:03:25.415253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.720465ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281484236 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1940 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:03:25.415655Z","caller":"traceutil/trace.go:171","msg":"trace[679524898] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"435.675851ms","start":"2026-03-17T22:03:24.979932Z","end":"2026-03-17T22:03:25.415608Z","steps":["trace[679524898] 'process raft request'  (duration: 435.523207ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:25.415686Z","caller":"traceutil/trace.go:171","msg":"trace[1955604655] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"436.581624ms","start":"2026-03-17T22:03:24.979046Z","end":"2026-03-17T22:03:25.415628Z","steps":["trace[1955604655] 'process raft request'  (duration: 214.339876ms)","trace[1955604655] 'compare'  (duration: 221.490348ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:03:25.415724Z","caller":"traceutil/trace.go:171","msg":"trace[163770426] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"435.436654ms","start":"2026-03-17T22:03:24.980184Z","end":"2026-03-17T22:03:25.415621Z","steps":["trace[163770426] 'process raft request'  (duration: 435.341722ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:25.415844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.980158Z","time spent":"435.63697ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1942 > 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\" > >"}
{"level":"info","ts":"2026-03-17T22:03:25.415827Z","caller":"traceutil/trace.go:171","msg":"trace[1638891968] linearizableReadLoop","detail":"{readStateIndex:2027; appliedIndex:2023; }","duration":"356.000038ms","start":"2026-03-17T22:03:25.059785Z","end":"2026-03-17T22:03:25.415785Z","steps":["trace[1638891968] 'read index received'  (duration: 133.623665ms)","trace[1638891968] 'applied index is now lower than readState.Index'  (duration: 222.372852ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:03:25.415885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.979016Z","time spent":"436.757699ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1940 > 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-03-17T22:03:25.415887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.979917Z","time spent":"435.849655ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1941 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-17T22:03:25.415853Z","caller":"traceutil/trace.go:171","msg":"trace[1638985235] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"435.008333ms","start":"2026-03-17T22:03:24.980794Z","end":"2026-03-17T22:03:25.415802Z","steps":["trace[1638985235] 'process raft request'  (duration: 434.779657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:25.415964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.179152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:03:25.41603Z","caller":"traceutil/trace.go:171","msg":"trace[18957257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1955; }","duration":"356.288576ms","start":"2026-03-17T22:03:25.059721Z","end":"2026-03-17T22:03:25.41601Z","steps":["trace[18957257] 'agreement among raft nodes before linearized reading'  (duration: 356.182183ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:25.416069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:25.059699Z","time spent":"356.362017ms","remote":"127.0.0.1:35364","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-03-17T22:03:25.416066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:03:24.980779Z","time spent":"435.177337ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1943 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-17T22:03:25.416557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.744848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T22:03:25.416603Z","caller":"traceutil/trace.go:171","msg":"trace[536407552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1955; }","duration":"272.828419ms","start":"2026-03-17T22:03:25.143763Z","end":"2026-03-17T22:03:25.416592Z","steps":["trace[536407552] 'agreement among raft nodes before linearized reading'  (duration: 272.205013ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:35.621209Z","caller":"traceutil/trace.go:171","msg":"trace[75695802] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"130.332187ms","start":"2026-03-17T22:03:35.490844Z","end":"2026-03-17T22:03:35.621177Z","steps":["trace[75695802] 'process raft request'  (duration: 75.391969ms)","trace[75695802] 'compare'  (duration: 54.798624ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:03:35.627985Z","caller":"traceutil/trace.go:171","msg":"trace[217418244] linearizableReadLoop","detail":"{readStateIndex:2082; appliedIndex:2079; }","duration":"101.901981ms","start":"2026-03-17T22:03:35.526025Z","end":"2026-03-17T22:03:35.627927Z","steps":["trace[217418244] 'read index received'  (duration: 40.207932ms)","trace[217418244] 'applied index is now lower than readState.Index'  (duration: 61.692559ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:03:35.628013Z","caller":"traceutil/trace.go:171","msg":"trace[288930532] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"137.100958ms","start":"2026-03-17T22:03:35.490858Z","end":"2026-03-17T22:03:35.627959Z","steps":["trace[288930532] 'process raft request'  (duration: 135.67193ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:35.62803Z","caller":"traceutil/trace.go:171","msg":"trace[1841716911] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"136.364229ms","start":"2026-03-17T22:03:35.491612Z","end":"2026-03-17T22:03:35.627976Z","steps":["trace[1841716911] 'process raft request'  (duration: 136.256556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:03:35.628205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.151128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T22:03:35.628253Z","caller":"traceutil/trace.go:171","msg":"trace[477121408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2008; }","duration":"102.247601ms","start":"2026-03-17T22:03:35.525992Z","end":"2026-03-17T22:03:35.62824Z","steps":["trace[477121408] 'agreement among raft nodes before linearized reading'  (duration: 102.085086ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:37.789215Z","caller":"traceutil/trace.go:171","msg":"trace[1500770695] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"155.351549ms","start":"2026-03-17T22:03:37.633838Z","end":"2026-03-17T22:03:37.789189Z","steps":["trace[1500770695] 'process raft request'  (duration: 155.205585ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:37.802179Z","caller":"traceutil/trace.go:171","msg":"trace[1780322815] linearizableReadLoop","detail":"{readStateIndex:2090; appliedIndex:2088; }","duration":"122.516146ms","start":"2026-03-17T22:03:37.679647Z","end":"2026-03-17T22:03:37.802163Z","steps":["trace[1780322815] 'read index received'  (duration: 109.522007ms)","trace[1780322815] 'applied index is now lower than readState.Index'  (duration: 12.993409ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:03:37.802379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.707071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T22:03:37.802456Z","caller":"traceutil/trace.go:171","msg":"trace[1486397396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2017; }","duration":"122.800954ms","start":"2026-03-17T22:03:37.67961Z","end":"2026-03-17T22:03:37.802411Z","steps":["trace[1486397396] 'agreement among raft nodes before linearized reading'  (duration: 122.621419ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:37.802725Z","caller":"traceutil/trace.go:171","msg":"trace[1418164078] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"166.401237ms","start":"2026-03-17T22:03:37.636313Z","end":"2026-03-17T22:03:37.802714Z","steps":["trace[1418164078] 'process raft request'  (duration: 165.704188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:37.802962Z","caller":"traceutil/trace.go:171","msg":"trace[561852786] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"166.143009ms","start":"2026-03-17T22:03:37.636805Z","end":"2026-03-17T22:03:37.802948Z","steps":["trace[561852786] 'process raft request'  (duration: 165.282576ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:03:38.088269Z","caller":"traceutil/trace.go:171","msg":"trace[1353056090] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"192.015986ms","start":"2026-03-17T22:03:37.896218Z","end":"2026-03-17T22:03:38.088234Z","steps":["trace[1353056090] 'process raft request'  (duration: 153.765407ms)","trace[1353056090] 'compare'  (duration: 37.784816ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:03.135148Z","caller":"traceutil/trace.go:171","msg":"trace[1870220084] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"124.247727ms","start":"2026-03-17T22:04:03.010863Z","end":"2026-03-17T22:04:03.13511Z","steps":["trace[1870220084] 'process raft request'  (duration: 124.00261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:06.060988Z","caller":"traceutil/trace.go:171","msg":"trace[1731998032] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"106.4333ms","start":"2026-03-17T22:04:05.954515Z","end":"2026-03-17T22:04:06.060949Z","steps":["trace[1731998032] 'process raft request'  (duration: 46.869264ms)","trace[1731998032] 'compare'  (duration: 59.381691ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:06.075806Z","caller":"traceutil/trace.go:171","msg":"trace[1373627781] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"120.831396ms","start":"2026-03-17T22:04:05.954948Z","end":"2026-03-17T22:04:06.07578Z","steps":["trace[1373627781] 'process raft request'  (duration: 120.515697ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:06.076009Z","caller":"traceutil/trace.go:171","msg":"trace[348464571] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"117.22263ms","start":"2026-03-17T22:04:05.958737Z","end":"2026-03-17T22:04:06.07596Z","steps":["trace[348464571] 'process raft request'  (duration: 117.070036ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:06.439036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.281559ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281484869 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/openstack/sh.helm.release.v1.valkey.v1\" mod_revision:2212 > success:<request_put:<key:\"/registry/secrets/openstack/sh.helm.release.v1.valkey.v1\" value_size:144569 >> failure:<request_range:<key:\"/registry/secrets/openstack/sh.helm.release.v1.valkey.v1\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:04:06.439161Z","caller":"traceutil/trace.go:171","msg":"trace[1410646989] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"284.997752ms","start":"2026-03-17T22:04:06.154142Z","end":"2026-03-17T22:04:06.439139Z","steps":["trace[1410646989] 'process raft request'  (duration: 182.518068ms)","trace[1410646989] 'compare'  (duration: 102.010192ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:06.443022Z","caller":"traceutil/trace.go:171","msg":"trace[947708522] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"282.169526ms","start":"2026-03-17T22:04:06.160827Z","end":"2026-03-17T22:04:06.442997Z","steps":["trace[947708522] 'process raft request'  (duration: 281.772606ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:06.443248Z","caller":"traceutil/trace.go:171","msg":"trace[1072009911] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"282.909946ms","start":"2026-03-17T22:04:06.160324Z","end":"2026-03-17T22:04:06.443234Z","steps":["trace[1072009911] 'process raft request'  (duration: 282.043253ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:06.443343Z","caller":"traceutil/trace.go:171","msg":"trace[1804008877] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"278.249061ms","start":"2026-03-17T22:04:06.165041Z","end":"2026-03-17T22:04:06.443291Z","steps":["trace[1804008877] 'process raft request'  (duration: 277.82915ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:06.443384Z","caller":"traceutil/trace.go:171","msg":"trace[480238143] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"206.52047ms","start":"2026-03-17T22:04:06.236834Z","end":"2026-03-17T22:04:06.443354Z","steps":["trace[480238143] 'process raft request'  (duration: 206.15161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:06.443717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.139557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-17T22:04:06.443669Z","caller":"traceutil/trace.go:171","msg":"trace[827639799] linearizableReadLoop","detail":"{readStateIndex:2330; appliedIndex:2326; }","duration":"212.515071ms","start":"2026-03-17T22:04:06.230583Z","end":"2026-03-17T22:04:06.443098Z","steps":["trace[827639799] 'read index received'  (duration: 106.03681ms)","trace[827639799] 'applied index is now lower than readState.Index'  (duration: 106.476221ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:06.443768Z","caller":"traceutil/trace.go:171","msg":"trace[2084189681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2245; }","duration":"213.243611ms","start":"2026-03-17T22:04:06.230511Z","end":"2026-03-17T22:04:06.443754Z","steps":["trace[2084189681] 'agreement among raft nodes before linearized reading'  (duration: 213.052066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:06.445241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.030378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-17T22:04:06.445304Z","caller":"traceutil/trace.go:171","msg":"trace[483143859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2245; }","duration":"209.174301ms","start":"2026-03-17T22:04:06.236115Z","end":"2026-03-17T22:04:06.44529Z","steps":["trace[483143859] 'agreement among raft nodes before linearized reading'  (duration: 208.810841ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:44.48044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.701241ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281485571 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2522 > 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:16"}
{"level":"info","ts":"2026-03-17T22:04:44.480619Z","caller":"traceutil/trace.go:171","msg":"trace[1428176731] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"137.013749ms","start":"2026-03-17T22:04:44.34356Z","end":"2026-03-17T22:04:44.480574Z","steps":["trace[1428176731] 'process raft request'  (duration: 25.081412ms)","trace[1428176731] 'compare'  (duration: 111.587298ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:50.634515Z","caller":"traceutil/trace.go:171","msg":"trace[478731579] transaction","detail":"{read_only:false; response_revision:2558; number_of_response:1; }","duration":"259.55808ms","start":"2026-03-17T22:04:50.374921Z","end":"2026-03-17T22:04:50.634479Z","steps":["trace[478731579] 'process raft request'  (duration: 259.321653ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:50.725921Z","caller":"traceutil/trace.go:171","msg":"trace[1295458139] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"332.612826ms","start":"2026-03-17T22:04:50.393272Z","end":"2026-03-17T22:04:50.725885Z","steps":["trace[1295458139] 'process raft request'  (duration: 332.352969ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:50.726201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:50.393212Z","time spent":"332.816421ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2550 > 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-03-17T22:04:50.726365Z","caller":"traceutil/trace.go:171","msg":"trace[976100866] transaction","detail":"{read_only:false; response_revision:2560; number_of_response:1; }","duration":"219.767025ms","start":"2026-03-17T22:04:50.506505Z","end":"2026-03-17T22:04:50.726272Z","steps":["trace[976100866] 'process raft request'  (duration: 219.305832ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:50.726354Z","caller":"traceutil/trace.go:171","msg":"trace[1059525397] linearizableReadLoop","detail":"{readStateIndex:2656; appliedIndex:2654; }","duration":"315.699463ms","start":"2026-03-17T22:04:50.410619Z","end":"2026-03-17T22:04:50.726318Z","steps":["trace[1059525397] 'read index received'  (duration: 223.750181ms)","trace[1059525397] 'applied index is now lower than readState.Index'  (duration: 91.948192ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:04:50.726958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.313819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-17T22:04:50.726995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.189855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-17T22:04:50.7271Z","caller":"traceutil/trace.go:171","msg":"trace[1773368666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2561; }","duration":"214.325818ms","start":"2026-03-17T22:04:50.512743Z","end":"2026-03-17T22:04:50.727068Z","steps":["trace[1773368666] 'agreement among raft nodes before linearized reading'  (duration: 214.02085ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:50.727046Z","caller":"traceutil/trace.go:171","msg":"trace[343274034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2561; }","duration":"316.465923ms","start":"2026-03-17T22:04:50.410531Z","end":"2026-03-17T22:04:50.726997Z","steps":["trace[343274034] 'agreement among raft nodes before linearized reading'  (duration: 316.171245ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:50.727245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:50.410501Z","time spent":"316.666869ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-17T22:04:50.841652Z","caller":"traceutil/trace.go:171","msg":"trace[1015605570] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"108.523346ms","start":"2026-03-17T22:04:50.733079Z","end":"2026-03-17T22:04:50.841602Z","steps":["trace[1015605570] 'process raft request'  (duration: 33.128047ms)","trace[1015605570] 'compare'  (duration: 75.163363ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:50.841678Z","caller":"traceutil/trace.go:171","msg":"trace[161524059] transaction","detail":"{read_only:false; response_revision:2563; number_of_response:1; }","duration":"108.556507ms","start":"2026-03-17T22:04:50.733079Z","end":"2026-03-17T22:04:50.841636Z","steps":["trace[161524059] 'process raft request'  (duration: 108.459635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:51.399515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.565924ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281485655 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2555 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:04:51.399808Z","caller":"traceutil/trace.go:171","msg":"trace[1509374077] transaction","detail":"{read_only:false; response_revision:2564; number_of_response:1; }","duration":"548.831927ms","start":"2026-03-17T22:04:50.850937Z","end":"2026-03-17T22:04:51.399769Z","steps":["trace[1509374077] 'process raft request'  (duration: 171.913674ms)","trace[1509374077] 'compare'  (duration: 376.41715ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:51.399877Z","caller":"traceutil/trace.go:171","msg":"trace[2125167934] linearizableReadLoop","detail":"{readStateIndex:2662; appliedIndex:2660; }","duration":"502.356973ms","start":"2026-03-17T22:04:50.897504Z","end":"2026-03-17T22:04:51.399861Z","steps":["trace[2125167934] 'read index received'  (duration: 125.364537ms)","trace[2125167934] 'applied index is now lower than readState.Index'  (duration: 376.991416ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:04:51.399933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:50.850922Z","time spent":"548.95617ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2555 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-17T22:04:51.40006Z","caller":"traceutil/trace.go:171","msg":"trace[1106720181] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"548.895129ms","start":"2026-03-17T22:04:50.851109Z","end":"2026-03-17T22:04:51.400004Z","steps":["trace[1106720181] 'process raft request'  (duration: 548.528969ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:51.400242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:50.851084Z","time spent":"549.054463ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2554 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-17T22:04:51.400469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.960329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.189dc01fc2f8fb28\" ","response":"range_response_count:1 size:765"}
{"level":"info","ts":"2026-03-17T22:04:51.400563Z","caller":"traceutil/trace.go:171","msg":"trace[1521044394] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.189dc01fc2f8fb28; range_end:; response_count:1; response_revision:2565; }","duration":"503.099303ms","start":"2026-03-17T22:04:50.897434Z","end":"2026-03-17T22:04:51.400534Z","steps":["trace[1521044394] 'agreement among raft nodes before linearized reading'  (duration: 502.837486ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:51.400613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:50.897401Z","time spent":"503.199716ms","remote":"127.0.0.1:35460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":789,"request content":"key:\"/registry/events/openstack/valkey-node-0.189dc01fc2f8fb28\" "}
{"level":"info","ts":"2026-03-17T22:04:52.241713Z","caller":"traceutil/trace.go:171","msg":"trace[2033196154] linearizableReadLoop","detail":"{readStateIndex:2663; appliedIndex:2662; }","duration":"445.960473ms","start":"2026-03-17T22:04:51.795696Z","end":"2026-03-17T22:04:52.241656Z","steps":["trace[2033196154] 'read index received'  (duration: 442.004847ms)","trace[2033196154] 'applied index is now lower than readState.Index'  (duration: 3.953866ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:04:52.241997Z","caller":"traceutil/trace.go:171","msg":"trace[44976800] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"838.936167ms","start":"2026-03-17T22:04:51.403018Z","end":"2026-03-17T22:04:52.241954Z","steps":["trace[44976800] 'process raft request'  (duration: 834.395975ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:52.242085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.353673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T22:04:52.242204Z","caller":"traceutil/trace.go:171","msg":"trace[634460088] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2566; }","duration":"446.512727ms","start":"2026-03-17T22:04:51.795652Z","end":"2026-03-17T22:04:52.242164Z","steps":["trace[634460088] 'agreement among raft nodes before linearized reading'  (duration: 446.315252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:52.242242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.196223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:04:52.242235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.167379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"warn","ts":"2026-03-17T22:04:52.242293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:51.795625Z","time spent":"446.649551ms","remote":"127.0.0.1:35930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-03-17T22:04:52.242336Z","caller":"traceutil/trace.go:171","msg":"trace[1680713089] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2566; }","duration":"151.307452ms","start":"2026-03-17T22:04:52.090999Z","end":"2026-03-17T22:04:52.242306Z","steps":["trace[1680713089] 'agreement among raft nodes before linearized reading'  (duration: 151.059026ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:52.242356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:04:51.402992Z","time spent":"839.115591ms","remote":"127.0.0.1:35460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/valkey-node-0.189dc01fc2f8fb28\" mod_revision:2516 > success:<request_put:<key:\"/registry/events/openstack/valkey-node-0.189dc01fc2f8fb28\" value_size:675 lease:2594527474281484757 >> failure:<request_range:<key:\"/registry/events/openstack/valkey-node-0.189dc01fc2f8fb28\" > >"}
{"level":"info","ts":"2026-03-17T22:04:52.242444Z","caller":"traceutil/trace.go:171","msg":"trace[1255305360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2566; }","duration":"184.46622ms","start":"2026-03-17T22:04:52.057871Z","end":"2026-03-17T22:04:52.242337Z","steps":["trace[1255305360] 'agreement among raft nodes before linearized reading'  (duration: 184.188473ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:04:52.245463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.72124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-17T22:04:52.245599Z","caller":"traceutil/trace.go:171","msg":"trace[1632024603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2566; }","duration":"102.901225ms","start":"2026-03-17T22:04:52.142663Z","end":"2026-03-17T22:04:52.245564Z","steps":["trace[1632024603] 'agreement among raft nodes before linearized reading'  (duration: 99.391822ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:04:56.774371Z","caller":"traceutil/trace.go:171","msg":"trace[109024499] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"117.166878ms","start":"2026-03-17T22:04:56.657174Z","end":"2026-03-17T22:04:56.774341Z","steps":["trace[109024499] 'process raft request'  (duration: 116.87682ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:07:01.734803Z","caller":"traceutil/trace.go:171","msg":"trace[2111582236] transaction","detail":"{read_only:false; response_revision:3180; number_of_response:1; }","duration":"106.200187ms","start":"2026-03-17T22:07:01.62858Z","end":"2026-03-17T22:07:01.734781Z","steps":["trace[2111582236] 'process raft request'  (duration: 106.013722ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:07:16.028354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.816264ms","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-03-17T22:07:16.028546Z","caller":"traceutil/trace.go:171","msg":"trace[336596938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3371; }","duration":"132.065531ms","start":"2026-03-17T22:07:15.896448Z","end":"2026-03-17T22:07:16.028514Z","steps":["trace[336596938] 'range keys from in-memory index tree'  (duration: 131.486856ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:07:20.184867Z","caller":"traceutil/trace.go:171","msg":"trace[1389396993] transaction","detail":"{read_only:false; response_revision:3458; number_of_response:1; }","duration":"122.935076ms","start":"2026-03-17T22:07:20.061912Z","end":"2026-03-17T22:07:20.184847Z","steps":["trace[1389396993] 'process raft request'  (duration: 122.543966ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:07:49.002298Z","caller":"traceutil/trace.go:171","msg":"trace[1123678587] linearizableReadLoop","detail":"{readStateIndex:3753; appliedIndex:3752; }","duration":"166.501015ms","start":"2026-03-17T22:07:48.835764Z","end":"2026-03-17T22:07:49.002265Z","steps":["trace[1123678587] 'read index received'  (duration: 166.255998ms)","trace[1123678587] 'applied index is now lower than readState.Index'  (duration: 243.527µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:07:49.002861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.0809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T22:07:49.002916Z","caller":"traceutil/trace.go:171","msg":"trace[561043709] transaction","detail":"{read_only:false; response_revision:3614; number_of_response:1; }","duration":"391.156668ms","start":"2026-03-17T22:07:48.611729Z","end":"2026-03-17T22:07:49.002886Z","steps":["trace[561043709] 'process raft request'  (duration: 390.367607ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:07:49.003051Z","caller":"traceutil/trace.go:171","msg":"trace[239008679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3614; }","duration":"167.243665ms","start":"2026-03-17T22:07:48.835702Z","end":"2026-03-17T22:07:49.002946Z","steps":["trace[239008679] 'agreement among raft nodes before linearized reading'  (duration: 166.871185ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:07:49.003122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:07:48.611707Z","time spent":"391.291442ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:3605 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-17T22:07:49.272256Z","caller":"traceutil/trace.go:171","msg":"trace[930276084] transaction","detail":"{read_only:false; response_revision:3615; number_of_response:1; }","duration":"261.527043ms","start":"2026-03-17T22:07:49.01068Z","end":"2026-03-17T22:07:49.272207Z","steps":["trace[930276084] 'process raft request'  (duration: 181.202019ms)","trace[930276084] 'compare'  (duration: 80.064717ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:08:13.325501Z","caller":"traceutil/trace.go:171","msg":"trace[1840183175] linearizableReadLoop","detail":"{readStateIndex:3876; appliedIndex:3875; }","duration":"195.946864ms","start":"2026-03-17T22:08:13.129521Z","end":"2026-03-17T22:08:13.325468Z","steps":["trace[1840183175] 'read index received'  (duration: 195.722628ms)","trace[1840183175] 'applied index is now lower than readState.Index'  (duration: 223.146µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:08:13.32555Z","caller":"traceutil/trace.go:171","msg":"trace[28483574] transaction","detail":"{read_only:false; response_revision:3732; number_of_response:1; }","duration":"275.278741ms","start":"2026-03-17T22:08:13.050246Z","end":"2026-03-17T22:08:13.325525Z","steps":["trace[28483574] 'process raft request'  (duration: 275.046215ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:08:13.325812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.269754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T22:08:13.325903Z","caller":"traceutil/trace.go:171","msg":"trace[219320883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3732; }","duration":"196.428848ms","start":"2026-03-17T22:08:13.129454Z","end":"2026-03-17T22:08:13.325883Z","steps":["trace[219320883] 'agreement among raft nodes before linearized reading'  (duration: 196.14011ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:14.027439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.925973ms","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-03-17T22:09:14.027579Z","caller":"traceutil/trace.go:171","msg":"trace[50413687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4624; }","duration":"109.144949ms","start":"2026-03-17T22:09:13.9184Z","end":"2026-03-17T22:09:14.027545Z","steps":["trace[50413687] 'range keys from in-memory index tree'  (duration: 108.695098ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:15.099461Z","caller":"traceutil/trace.go:171","msg":"trace[280940130] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"278.386662ms","start":"2026-03-17T22:09:14.821029Z","end":"2026-03-17T22:09:15.099416Z","steps":["trace[280940130] 'process raft request'  (duration: 278.045092ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:15.100744Z","caller":"traceutil/trace.go:171","msg":"trace[1826964087] linearizableReadLoop","detail":"{readStateIndex:4812; appliedIndex:4810; }","duration":"186.083694ms","start":"2026-03-17T22:09:14.91463Z","end":"2026-03-17T22:09:15.100713Z","steps":["trace[1826964087] 'read index received'  (duration: 184.370368ms)","trace[1826964087] 'applied index is now lower than readState.Index'  (duration: 1.712356ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:15.100838Z","caller":"traceutil/trace.go:171","msg":"trace[1480028726] transaction","detail":"{read_only:false; response_revision:4633; number_of_response:1; }","duration":"279.629574ms","start":"2026-03-17T22:09:14.821201Z","end":"2026-03-17T22:09:15.100831Z","steps":["trace[1480028726] 'process raft request'  (duration: 279.386758ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:15.10119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.524166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-xk2ql\" ","response":"range_response_count:1 size:5148"}
{"level":"info","ts":"2026-03-17T22:09:15.101314Z","caller":"traceutil/trace.go:171","msg":"trace[1524386909] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-xk2ql; range_end:; response_count:1; response_revision:4633; }","duration":"186.68079ms","start":"2026-03-17T22:09:14.914601Z","end":"2026-03-17T22:09:15.101282Z","steps":["trace[1524386909] 'agreement among raft nodes before linearized reading'  (duration: 186.365961ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:18.762967Z","caller":"traceutil/trace.go:171","msg":"trace[18577698] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"329.121383ms","start":"2026-03-17T22:09:18.433832Z","end":"2026-03-17T22:09:18.762953Z","steps":["trace[18577698] 'process raft request'  (duration: 329.02864ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:18.763061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.43381Z","time spent":"329.209036ms","remote":"127.0.0.1:51866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2499,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/monitoring/vector-6g7lx\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/monitoring/vector-6g7lx\" value_size:2432 >> failure:<>"}
{"level":"info","ts":"2026-03-17T22:09:18.763072Z","caller":"traceutil/trace.go:171","msg":"trace[47501471] linearizableReadLoop","detail":"{readStateIndex:4959; appliedIndex:4959; }","duration":"300.112545ms","start":"2026-03-17T22:09:18.462906Z","end":"2026-03-17T22:09:18.763018Z","steps":["trace[47501471] 'read index received'  (duration: 300.092534ms)","trace[47501471] 'applied index is now lower than readState.Index'  (duration: 16.46µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:09:18.763251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.3367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-17T22:09:18.763302Z","caller":"traceutil/trace.go:171","msg":"trace[257156887] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a; range_end:; response_count:1; response_revision:4776; }","duration":"300.433273ms","start":"2026-03-17T22:09:18.462858Z","end":"2026-03-17T22:09:18.763291Z","steps":["trace[257156887] 'agreement among raft nodes before linearized reading'  (duration: 300.271779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:18.763328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.462834Z","time spent":"300.488545ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3625,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" "}
{"level":"info","ts":"2026-03-17T22:09:19.171161Z","caller":"traceutil/trace.go:171","msg":"trace[2092370161] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4959; }","duration":"407.951307ms","start":"2026-03-17T22:09:18.763172Z","end":"2026-03-17T22:09:19.171124Z","steps":["trace[2092370161] 'read index received'  (duration: 399.372237ms)","trace[2092370161] 'applied index is now lower than readState.Index'  (duration: 8.57745ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:19.171236Z","caller":"traceutil/trace.go:171","msg":"trace[272042976] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"614.760327ms","start":"2026-03-17T22:09:18.556428Z","end":"2026-03-17T22:09:19.171188Z","steps":["trace[272042976] 'process raft request'  (duration: 606.111215ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:19.171488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.556399Z","time spent":"614.960902ms","remote":"127.0.0.1:37992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":413742,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:3434 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:413674 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"warn","ts":"2026-03-17T22:09:19.171477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.291648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-03-17T22:09:19.171491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.583402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-17T22:09:19.171593Z","caller":"traceutil/trace.go:171","msg":"trace[607957106] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a; range_end:; response_count:1; response_revision:4777; }","duration":"689.444082ms","start":"2026-03-17T22:09:18.482115Z","end":"2026-03-17T22:09:19.171559Z","steps":["trace[607957106] 'agreement among raft nodes before linearized reading'  (duration: 689.129033ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:19.171612Z","caller":"traceutil/trace.go:171","msg":"trace[1770658148] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:4777; }","duration":"418.762858ms","start":"2026-03-17T22:09:18.752823Z","end":"2026-03-17T22:09:19.171585Z","steps":["trace[1770658148] 'agreement among raft nodes before linearized reading'  (duration: 418.365597ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:19.17164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.482097Z","time spent":"689.532654ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3625,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" "}
{"level":"warn","ts":"2026-03-17T22:09:19.171662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.752805Z","time spent":"418.846019ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-x2znm\" "}
{"level":"info","ts":"2026-03-17T22:09:19.183658Z","caller":"traceutil/trace.go:171","msg":"trace[383812272] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"411.160433ms","start":"2026-03-17T22:09:18.772472Z","end":"2026-03-17T22:09:19.183632Z","steps":["trace[383812272] 'process raft request'  (duration: 410.940727ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:19.183773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.45907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:09:19.183817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.772431Z","time spent":"411.296298ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" mod_revision:4746 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" value_size:3606 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b0d2029-3dd6-4419-9c94-f86ed88a9d7a\" > >"}
{"level":"warn","ts":"2026-03-17T22:09:19.183811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.489577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T22:09:19.183955Z","caller":"traceutil/trace.go:171","msg":"trace[136794862] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:4778; }","duration":"400.698683ms","start":"2026-03-17T22:09:18.783224Z","end":"2026-03-17T22:09:19.183922Z","steps":["trace[136794862] 'agreement among raft nodes before linearized reading'  (duration: 400.428786ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:19.184037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.872006ms","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-03-17T22:09:19.184069Z","caller":"traceutil/trace.go:171","msg":"trace[2113450423] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4778; }","duration":"236.941178ms","start":"2026-03-17T22:09:18.947119Z","end":"2026-03-17T22:09:19.18406Z","steps":["trace[2113450423] 'agreement among raft nodes before linearized reading'  (duration: 236.805704ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:19.184061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:09:18.783208Z","time spent":"400.829196ms","remote":"127.0.0.1:35532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":5,"response size":31,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"info","ts":"2026-03-17T22:09:19.183856Z","caller":"traceutil/trace.go:171","msg":"trace[1646729597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4778; }","duration":"124.593364ms","start":"2026-03-17T22:09:19.059245Z","end":"2026-03-17T22:09:19.183838Z","steps":["trace[1646729597] 'agreement among raft nodes before linearized reading'  (duration: 124.46831ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:19.763185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.231963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777481"}
{"level":"info","ts":"2026-03-17T22:09:19.763393Z","caller":"traceutil/trace.go:171","msg":"trace[990491123] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4781; }","duration":"273.488609ms","start":"2026-03-17T22:09:19.489879Z","end":"2026-03-17T22:09:19.763368Z","steps":["trace[990491123] 'range keys from in-memory index tree'  (duration: 272.543334ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:21.478054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.952001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281491254 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4780 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:09:21.478265Z","caller":"traceutil/trace.go:171","msg":"trace[1781224133] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"242.498768ms","start":"2026-03-17T22:09:21.235741Z","end":"2026-03-17T22:09:21.478239Z","steps":["trace[1781224133] 'process raft request'  (duration: 69.273269ms)","trace[1781224133] 'compare'  (duration: 172.725215ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:21.727666Z","caller":"traceutil/trace.go:171","msg":"trace[2080626212] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5008; }","duration":"167.339671ms","start":"2026-03-17T22:09:21.560302Z","end":"2026-03-17T22:09:21.727642Z","steps":["trace[2080626212] 'read index received'  (duration: 167.151986ms)","trace[2080626212] 'applied index is now lower than readState.Index'  (duration: 186.915µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:21.727941Z","caller":"traceutil/trace.go:171","msg":"trace[1147708962] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"171.141623ms","start":"2026-03-17T22:09:21.556787Z","end":"2026-03-17T22:09:21.727928Z","steps":["trace[1147708962] 'process raft request'  (duration: 170.738252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:21.728196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.657698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-03-17T22:09:21.728292Z","caller":"traceutil/trace.go:171","msg":"trace[356647527] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4824; }","duration":"142.770131ms","start":"2026-03-17T22:09:21.585497Z","end":"2026-03-17T22:09:21.728267Z","steps":["trace[356647527] 'agreement among raft nodes before linearized reading'  (duration: 142.490154ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:21.728685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.261786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/monitoring/ipmi-exporter\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:09:21.729491Z","caller":"traceutil/trace.go:171","msg":"trace[849742487] range","detail":"{range_begin:/registry/daemonsets/monitoring/ipmi-exporter; range_end:; response_count:0; response_revision:4824; }","duration":"168.522933ms","start":"2026-03-17T22:09:21.560227Z","end":"2026-03-17T22:09:21.72875Z","steps":["trace[849742487] 'agreement among raft nodes before linearized reading'  (duration: 167.871226ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:29.594026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.10121ms","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-03-17T22:09:29.594123Z","caller":"traceutil/trace.go:171","msg":"trace[302421039] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4972; }","duration":"111.261144ms","start":"2026-03-17T22:09:29.482846Z","end":"2026-03-17T22:09:29.594108Z","steps":["trace[302421039] 'range keys from in-memory index tree'  (duration: 110.891404ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.799936Z","caller":"traceutil/trace.go:171","msg":"trace[379632462] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"202.314144ms","start":"2026-03-17T22:09:29.597574Z","end":"2026-03-17T22:09:29.799888Z","steps":["trace[379632462] 'process raft request'  (duration: 202.011386ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.800083Z","caller":"traceutil/trace.go:171","msg":"trace[1894970901] linearizableReadLoop","detail":"{readStateIndex:5163; appliedIndex:5161; }","duration":"201.4087ms","start":"2026-03-17T22:09:29.598647Z","end":"2026-03-17T22:09:29.800056Z","steps":["trace[1894970901] 'read index received'  (duration: 64.458738ms)","trace[1894970901] 'applied index is now lower than readState.Index'  (duration: 136.948522ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:29.800183Z","caller":"traceutil/trace.go:171","msg":"trace[1092438718] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"196.56835ms","start":"2026-03-17T22:09:29.603587Z","end":"2026-03-17T22:09:29.800155Z","steps":["trace[1092438718] 'process raft request'  (duration: 196.215481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:29.800302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.643177ms","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-03-17T22:09:29.80034Z","caller":"traceutil/trace.go:171","msg":"trace[1440737111] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4975; }","duration":"201.700308ms","start":"2026-03-17T22:09:29.598629Z","end":"2026-03-17T22:09:29.800329Z","steps":["trace[1440737111] 'agreement among raft nodes before linearized reading'  (duration: 201.528684ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.962703Z","caller":"traceutil/trace.go:171","msg":"trace[444373684] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"155.822739ms","start":"2026-03-17T22:09:29.806856Z","end":"2026-03-17T22:09:29.962679Z","steps":["trace[444373684] 'process raft request'  (duration: 111.237453ms)","trace[444373684] 'compare'  (duration: 44.468333ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:29.974861Z","caller":"traceutil/trace.go:171","msg":"trace[1067890922] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"167.865481ms","start":"2026-03-17T22:09:29.806983Z","end":"2026-03-17T22:09:29.974848Z","steps":["trace[1067890922] 'process raft request'  (duration: 167.696576ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.975124Z","caller":"traceutil/trace.go:171","msg":"trace[371810542] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"167.918033ms","start":"2026-03-17T22:09:29.807186Z","end":"2026-03-17T22:09:29.975105Z","steps":["trace[371810542] 'process raft request'  (duration: 167.595994ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.975287Z","caller":"traceutil/trace.go:171","msg":"trace[1147611911] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5164; }","duration":"138.627937ms","start":"2026-03-17T22:09:29.836638Z","end":"2026-03-17T22:09:29.975266Z","steps":["trace[1147611911] 'read index received'  (duration: 81.473945ms)","trace[1147611911] 'applied index is now lower than readState.Index'  (duration: 57.152092ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:29.97534Z","caller":"traceutil/trace.go:171","msg":"trace[2041305802] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"167.157692ms","start":"2026-03-17T22:09:29.808142Z","end":"2026-03-17T22:09:29.9753Z","steps":["trace[2041305802] 'process raft request'  (duration: 166.889725ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:29.975516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.873274ms","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-03-17T22:09:29.975514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.707671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:09:29.975513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.63761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:09:29.975585Z","caller":"traceutil/trace.go:171","msg":"trace[611850588] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4979; }","duration":"106.871876ms","start":"2026-03-17T22:09:29.868689Z","end":"2026-03-17T22:09:29.975561Z","steps":["trace[611850588] 'agreement among raft nodes before linearized reading'  (duration: 106.732012ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.97559Z","caller":"traceutil/trace.go:171","msg":"trace[2008211699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4979; }","duration":"138.952556ms","start":"2026-03-17T22:09:29.836599Z","end":"2026-03-17T22:09:29.975552Z","steps":["trace[2008211699] 'agreement among raft nodes before linearized reading'  (duration: 138.769411ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:29.975598Z","caller":"traceutil/trace.go:171","msg":"trace[551319903] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4979; }","duration":"106.753533ms","start":"2026-03-17T22:09:29.868823Z","end":"2026-03-17T22:09:29.975577Z","steps":["trace[551319903] 'agreement among raft nodes before linearized reading'  (duration: 106.621929ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:36.613223Z","caller":"traceutil/trace.go:171","msg":"trace[1807028991] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"154.40592ms","start":"2026-03-17T22:09:36.458778Z","end":"2026-03-17T22:09:36.613184Z","steps":["trace[1807028991] 'process raft request'  (duration: 153.816454ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:38.170989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.844909ms","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-03-17T22:09:38.171125Z","caller":"traceutil/trace.go:171","msg":"trace[1825744332] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5109; }","duration":"134.009503ms","start":"2026-03-17T22:09:38.037091Z","end":"2026-03-17T22:09:38.171101Z","steps":["trace[1825744332] 'range keys from in-memory index tree'  (duration: 133.658414ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:38.171015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.2318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:09:38.171246Z","caller":"traceutil/trace.go:171","msg":"trace[1188864049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5109; }","duration":"112.536828ms","start":"2026-03-17T22:09:38.058683Z","end":"2026-03-17T22:09:38.17122Z","steps":["trace[1188864049] 'range keys from in-memory index tree'  (duration: 111.899481ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:38.393726Z","caller":"traceutil/trace.go:171","msg":"trace[1904950124] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"219.193968ms","start":"2026-03-17T22:09:38.174507Z","end":"2026-03-17T22:09:38.393701Z","steps":["trace[1904950124] 'process raft request'  (duration: 219.039804ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:38.428041Z","caller":"traceutil/trace.go:171","msg":"trace[1988585337] linearizableReadLoop","detail":"{readStateIndex:5304; appliedIndex:5301; }","duration":"221.228432ms","start":"2026-03-17T22:09:38.206768Z","end":"2026-03-17T22:09:38.427996Z","steps":["trace[1988585337] 'read index received'  (duration: 186.86217ms)","trace[1988585337] 'applied index is now lower than readState.Index'  (duration: 34.364532ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:38.428112Z","caller":"traceutil/trace.go:171","msg":"trace[1996346000] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"237.402876ms","start":"2026-03-17T22:09:38.190704Z","end":"2026-03-17T22:09:38.428107Z","steps":["trace[1996346000] 'process raft request'  (duration: 237.246172ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:38.428281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.50508ms","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-03-17T22:09:38.428322Z","caller":"traceutil/trace.go:171","msg":"trace[782429701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5112; }","duration":"221.608133ms","start":"2026-03-17T22:09:38.206704Z","end":"2026-03-17T22:09:38.428313Z","steps":["trace[782429701] 'agreement among raft nodes before linearized reading'  (duration: 221.454369ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:38.428369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.386116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.189dc0670e406d33\" ","response":"range_response_count:1 size:1012"}
{"level":"info","ts":"2026-03-17T22:09:38.42805Z","caller":"traceutil/trace.go:171","msg":"trace[1961782923] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"252.907833ms","start":"2026-03-17T22:09:38.17511Z","end":"2026-03-17T22:09:38.428017Z","steps":["trace[1961782923] 'process raft request'  (duration: 252.703377ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:38.428407Z","caller":"traceutil/trace.go:171","msg":"trace[1163729889] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.189dc0670e406d33; range_end:; response_count:1; response_revision:5112; }","duration":"102.467628ms","start":"2026-03-17T22:09:38.32593Z","end":"2026-03-17T22:09:38.428397Z","steps":["trace[1163729889] 'agreement among raft nodes before linearized reading'  (duration: 102.328554ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:38.610052Z","caller":"traceutil/trace.go:171","msg":"trace[1426493349] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"179.223867ms","start":"2026-03-17T22:09:38.430792Z","end":"2026-03-17T22:09:38.610016Z","steps":["trace[1426493349] 'process raft request'  (duration: 100.362982ms)","trace[1426493349] 'compare'  (duration: 78.716281ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:38.678183Z","caller":"traceutil/trace.go:171","msg":"trace[1912524472] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"238.776553ms","start":"2026-03-17T22:09:38.439379Z","end":"2026-03-17T22:09:38.678156Z","steps":["trace[1912524472] 'process raft request'  (duration: 238.725402ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:38.678211Z","caller":"traceutil/trace.go:171","msg":"trace[808165999] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"245.679639ms","start":"2026-03-17T22:09:38.432506Z","end":"2026-03-17T22:09:38.678186Z","steps":["trace[808165999] 'process raft request'  (duration: 245.459113ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:38.870919Z","caller":"traceutil/trace.go:171","msg":"trace[922204243] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"153.29975ms","start":"2026-03-17T22:09:38.717591Z","end":"2026-03-17T22:09:38.87089Z","steps":["trace[922204243] 'process raft request'  (duration: 153.132846ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:39.324283Z","caller":"traceutil/trace.go:171","msg":"trace[1891462306] linearizableReadLoop","detail":"{readStateIndex:5310; appliedIndex:5309; }","duration":"110.699878ms","start":"2026-03-17T22:09:39.21355Z","end":"2026-03-17T22:09:39.32425Z","steps":["trace[1891462306] 'read index received'  (duration: 110.472812ms)","trace[1891462306] 'applied index is now lower than readState.Index'  (duration: 225.616µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:39.324387Z","caller":"traceutil/trace.go:171","msg":"trace[802042531] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"111.623563ms","start":"2026-03-17T22:09:39.212676Z","end":"2026-03-17T22:09:39.3243Z","steps":["trace[802042531] 'process raft request'  (duration: 111.369807ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:39.324583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.003127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"}
{"level":"info","ts":"2026-03-17T22:09:39.324689Z","caller":"traceutil/trace.go:171","msg":"trace[740899852] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5118; }","duration":"111.14425ms","start":"2026-03-17T22:09:39.213521Z","end":"2026-03-17T22:09:39.324665Z","steps":["trace[740899852] 'agreement among raft nodes before linearized reading'  (duration: 110.863703ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:47.080671Z","caller":"traceutil/trace.go:171","msg":"trace[1170653371] linearizableReadLoop","detail":"{readStateIndex:5475; appliedIndex:5474; }","duration":"163.944496ms","start":"2026-03-17T22:09:46.916687Z","end":"2026-03-17T22:09:47.080631Z","steps":["trace[1170653371] 'read index received'  (duration: 68.416254ms)","trace[1170653371] 'applied index is now lower than readState.Index'  (duration: 95.527332ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:09:47.080774Z","caller":"traceutil/trace.go:171","msg":"trace[2097210687] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"193.50636ms","start":"2026-03-17T22:09:46.887259Z","end":"2026-03-17T22:09:47.080765Z","steps":["trace[2097210687] 'process raft request'  (duration: 97.831924ms)","trace[2097210687] 'compare'  (duration: 95.264725ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:09:47.08095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.247465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-03-17T22:09:47.080976Z","caller":"traceutil/trace.go:171","msg":"trace[2078136607] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5279; }","duration":"164.317777ms","start":"2026-03-17T22:09:46.916649Z","end":"2026-03-17T22:09:47.080966Z","steps":["trace[2078136607] 'agreement among raft nodes before linearized reading'  (duration: 164.208794ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:09:47.267364Z","caller":"traceutil/trace.go:171","msg":"trace[2098687780] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"171.038827ms","start":"2026-03-17T22:09:47.096298Z","end":"2026-03-17T22:09:47.267336Z","steps":["trace[2098687780] 'process raft request'  (duration: 168.330714ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:09:53.020777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.460983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-03-17T22:09:53.020841Z","caller":"traceutil/trace.go:171","msg":"trace[1576697287] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5316; }","duration":"113.565616ms","start":"2026-03-17T22:09:52.907261Z","end":"2026-03-17T22:09:53.020827Z","steps":["trace[1576697287] 'range keys from in-memory index tree'  (duration: 113.325029ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:10:29.271855Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2752}
{"level":"info","ts":"2026-03-17T22:10:29.336123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2752,"took":"62.900897ms","hash":674159071,"current-db-size-bytes":40185856,"current-db-size":"40 MB","current-db-size-in-use-bytes":30003200,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-03-17T22:10:29.336212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":674159071,"revision":2752,"compact-revision":-1}
{"level":"info","ts":"2026-03-17T22:15:07.93166Z","caller":"traceutil/trace.go:171","msg":"trace[1129797992] transaction","detail":"{read_only:false; response_revision:7418; number_of_response:1; }","duration":"132.109954ms","start":"2026-03-17T22:15:07.799529Z","end":"2026-03-17T22:15:07.931639Z","steps":["trace[1129797992] 'process raft request'  (duration: 131.96437ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:15:29.288351Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5611}
{"level":"info","ts":"2026-03-17T22:15:29.39533Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5611,"took":"104.525786ms","hash":394379278,"current-db-size-bytes":41807872,"current-db-size":"42 MB","current-db-size-in-use-bytes":21733376,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-03-17T22:15:29.395439Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":394379278,"revision":5611,"compact-revision":2752}
{"level":"info","ts":"2026-03-17T22:15:54.192411Z","caller":"traceutil/trace.go:171","msg":"trace[2065359398] transaction","detail":"{read_only:false; response_revision:7706; number_of_response:1; }","duration":"127.977684ms","start":"2026-03-17T22:15:54.064403Z","end":"2026-03-17T22:15:54.192381Z","steps":["trace[2065359398] 'process raft request'  (duration: 87.684536ms)","trace[2065359398] 'compare'  (duration: 39.952069ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:00.996335Z","caller":"traceutil/trace.go:171","msg":"trace[31345078] transaction","detail":"{read_only:false; response_revision:7875; number_of_response:1; }","duration":"127.779428ms","start":"2026-03-17T22:16:00.868529Z","end":"2026-03-17T22:16:00.996308Z","steps":["trace[31345078] 'process raft request'  (duration: 127.627804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.028252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2594527474281499329,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:16:03.185925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:02.469195Z","time spent":"716.725032ms","remote":"127.0.0.1:35414","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-17T22:16:03.186378Z","caller":"traceutil/trace.go:171","msg":"trace[1528469487] linearizableReadLoop","detail":"{readStateIndex:8169; appliedIndex:8169; }","duration":"658.992708ms","start":"2026-03-17T22:16:02.527368Z","end":"2026-03-17T22:16:03.186361Z","steps":["trace[1528469487] 'read index received'  (duration: 658.989187ms)","trace[1528469487] 'applied index is now lower than readState.Index'  (duration: 2.961µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:16:03.186575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.788933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T22:16:03.186625Z","caller":"traceutil/trace.go:171","msg":"trace[41411971] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7881; }","duration":"655.873945ms","start":"2026-03-17T22:16:02.530724Z","end":"2026-03-17T22:16:03.186598Z","steps":["trace[41411971] 'agreement among raft nodes before linearized reading'  (duration: 655.734371ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.18663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.521205ms","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":"warn","ts":"2026-03-17T22:16:03.186662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:02.5307Z","time spent":"655.951936ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-17T22:16:03.186701Z","caller":"traceutil/trace.go:171","msg":"trace[1795208824] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:7881; }","duration":"412.635868ms","start":"2026-03-17T22:16:02.774047Z","end":"2026-03-17T22:16:03.186683Z","steps":["trace[1795208824] 'agreement among raft nodes before linearized reading'  (duration: 412.513745ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.186695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.401738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:16:03.186749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:02.774025Z","time spent":"412.713961ms","remote":"127.0.0.1:57480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"info","ts":"2026-03-17T22:16:03.186764Z","caller":"traceutil/trace.go:171","msg":"trace[423715161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7881; }","duration":"127.611144ms","start":"2026-03-17T22:16:03.059134Z","end":"2026-03-17T22:16:03.186746Z","steps":["trace[423715161] 'agreement among raft nodes before linearized reading'  (duration: 127.399758ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.186767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.534871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"warn","ts":"2026-03-17T22:16:03.186768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.524173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T22:16:03.186698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.327387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-17T22:16:03.186815Z","caller":"traceutil/trace.go:171","msg":"trace[444691384] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7881; }","duration":"444.626483ms","start":"2026-03-17T22:16:02.742177Z","end":"2026-03-17T22:16:03.186803Z","steps":["trace[444691384] 'agreement among raft nodes before linearized reading'  (duration: 444.48805ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.186839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:02.742153Z","time spent":"444.680805ms","remote":"127.0.0.1:35568","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":"info","ts":"2026-03-17T22:16:03.186841Z","caller":"traceutil/trace.go:171","msg":"trace[1717924099] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:7881; }","duration":"351.622226ms","start":"2026-03-17T22:16:02.835203Z","end":"2026-03-17T22:16:03.186825Z","steps":["trace[1717924099] 'agreement among raft nodes before linearized reading'  (duration: 351.40467ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:03.186845Z","caller":"traceutil/trace.go:171","msg":"trace[227996202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7881; }","duration":"659.506631ms","start":"2026-03-17T22:16:02.527325Z","end":"2026-03-17T22:16:03.186832Z","steps":["trace[227996202] 'agreement among raft nodes before linearized reading'  (duration: 659.192093ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.186873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:02.835138Z","time spent":"351.728799ms","remote":"127.0.0.1:35580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":52,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:16:03.18688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:02.527301Z","time spent":"659.568263ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-17T22:16:03.187094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.334995ms","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-03-17T22:16:03.187146Z","caller":"traceutil/trace.go:171","msg":"trace[1569424716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7881; }","duration":"186.415977ms","start":"2026-03-17T22:16:03.000717Z","end":"2026-03-17T22:16:03.187133Z","steps":["trace[1569424716] 'agreement among raft nodes before linearized reading'  (duration: 185.75457ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.639523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.711764ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281499334 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.149\" mod_revision:7700 > success:<request_put:<key:\"/registry/masterleases/199.204.45.149\" value_size:67 lease:2594527474281499330 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.149\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:16:03.639613Z","caller":"traceutil/trace.go:171","msg":"trace[2100268736] linearizableReadLoop","detail":"{readStateIndex:8170; appliedIndex:8169; }","duration":"451.171307ms","start":"2026-03-17T22:16:03.188427Z","end":"2026-03-17T22:16:03.639598Z","steps":["trace[2100268736] 'read index received'  (duration: 350.341429ms)","trace[2100268736] 'applied index is now lower than readState.Index'  (duration: 100.827837ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:03.639671Z","caller":"traceutil/trace.go:171","msg":"trace[1320891147] transaction","detail":"{read_only:false; response_revision:7882; number_of_response:1; }","duration":"452.457091ms","start":"2026-03-17T22:16:03.187205Z","end":"2026-03-17T22:16:03.639662Z","steps":["trace[1320891147] 'process raft request'  (duration: 351.522711ms)","trace[1320891147] 'compare'  (duration: 100.440567ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:16:03.639713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:03.187181Z","time spent":"452.510333ms","remote":"127.0.0.1:35414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.149\" mod_revision:7700 > success:<request_put:<key:\"/registry/masterleases/199.204.45.149\" value_size:67 lease:2594527474281499330 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.149\" > >"}
{"level":"warn","ts":"2026-03-17T22:16:03.639904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.459435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:16:03.640204Z","caller":"traceutil/trace.go:171","msg":"trace[428929731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7882; }","duration":"451.804324ms","start":"2026-03-17T22:16:03.188369Z","end":"2026-03-17T22:16:03.640173Z","steps":["trace[428929731] 'agreement among raft nodes before linearized reading'  (duration: 451.409063ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.640267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:03.188344Z","time spent":"451.906876ms","remote":"127.0.0.1:35366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-17T22:16:03.646515Z","caller":"traceutil/trace.go:171","msg":"trace[417251253] transaction","detail":"{read_only:false; response_revision:7883; number_of_response:1; }","duration":"455.76071ms","start":"2026-03-17T22:16:03.190726Z","end":"2026-03-17T22:16:03.646487Z","steps":["trace[417251253] 'process raft request'  (duration: 455.501993ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:03.646633Z","caller":"traceutil/trace.go:171","msg":"trace[1463176951] transaction","detail":"{read_only:false; response_revision:7884; number_of_response:1; }","duration":"455.479292ms","start":"2026-03-17T22:16:03.191126Z","end":"2026-03-17T22:16:03.646605Z","steps":["trace[1463176951] 'process raft request'  (duration: 455.249086ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:03.646669Z","caller":"traceutil/trace.go:171","msg":"trace[1399509609] transaction","detail":"{read_only:false; response_revision:7885; number_of_response:1; }","duration":"455.477422ms","start":"2026-03-17T22:16:03.191168Z","end":"2026-03-17T22:16:03.646645Z","steps":["trace[1399509609] 'process raft request'  (duration: 455.302537ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.646757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:03.191101Z","time spent":"455.602116ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:7875 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-17T22:16:03.646845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:03.191158Z","time spent":"455.623186ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:7874 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-17T22:16:03.646723Z","caller":"traceutil/trace.go:171","msg":"trace[120329939] transaction","detail":"{read_only:false; response_revision:7886; number_of_response:1; }","duration":"146.223601ms","start":"2026-03-17T22:16:03.500486Z","end":"2026-03-17T22:16:03.64671Z","steps":["trace[120329939] 'process raft request'  (duration: 146.033186ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.646661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:03.190717Z","time spent":"455.865612ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:7873 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-17T22:16:03.646959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.372556ms","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-03-17T22:16:03.64703Z","caller":"traceutil/trace.go:171","msg":"trace[379249699] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7887; }","duration":"456.459448ms","start":"2026-03-17T22:16:03.190563Z","end":"2026-03-17T22:16:03.647022Z","steps":["trace[379249699] 'agreement among raft nodes before linearized reading'  (duration: 456.338985ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:03.647057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:03.190548Z","time spent":"456.50473ms","remote":"127.0.0.1:35568","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":"info","ts":"2026-03-17T22:16:03.646923Z","caller":"traceutil/trace.go:171","msg":"trace[1818425037] transaction","detail":"{read_only:false; response_revision:7887; number_of_response:1; }","duration":"145.158213ms","start":"2026-03-17T22:16:03.501692Z","end":"2026-03-17T22:16:03.64685Z","steps":["trace[1818425037] 'process raft request'  (duration: 144.857475ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:13.798735Z","caller":"traceutil/trace.go:171","msg":"trace[197005294] transaction","detail":"{read_only:false; response_revision:7931; number_of_response:1; }","duration":"103.505909ms","start":"2026-03-17T22:16:13.695208Z","end":"2026-03-17T22:16:13.798714Z","steps":["trace[197005294] 'process raft request'  (duration: 103.360505ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:14.228279Z","caller":"traceutil/trace.go:171","msg":"trace[2124328130] linearizableReadLoop","detail":"{readStateIndex:8222; appliedIndex:8220; }","duration":"518.777896ms","start":"2026-03-17T22:16:13.709476Z","end":"2026-03-17T22:16:14.228254Z","steps":["trace[2124328130] 'read index received'  (duration: 89.089363ms)","trace[2124328130] 'applied index is now lower than readState.Index'  (duration: 429.687063ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:14.228349Z","caller":"traceutil/trace.go:171","msg":"trace[410211526] transaction","detail":"{read_only:false; response_revision:7932; number_of_response:1; }","duration":"525.298031ms","start":"2026-03-17T22:16:13.703003Z","end":"2026-03-17T22:16:14.228301Z","steps":["trace[410211526] 'process raft request'  (duration: 495.310048ms)","trace[410211526] 'compare'  (duration: 29.785017ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:16:14.228486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.993332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-17T22:16:14.228492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.702972Z","time spent":"525.451415ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:7887 > 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-03-17T22:16:14.228514Z","caller":"traceutil/trace.go:171","msg":"trace[1256768798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7932; }","duration":"519.060054ms","start":"2026-03-17T22:16:13.709446Z","end":"2026-03-17T22:16:14.228506Z","steps":["trace[1256768798] 'agreement among raft nodes before linearized reading'  (duration: 518.91373ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.228542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.709435Z","time spent":"519.097545ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-17T22:16:14.288878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.177781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-17T22:16:14.288945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.142568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-17T22:16:14.288996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.260402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T22:16:14.289166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.648539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-17T22:16:14.289195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.608928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6f686f9ddc-lvtsh.189dc0bed1b3e0f0\" ","response":"range_response_count:1 size:1135"}
{"level":"warn","ts":"2026-03-17T22:16:14.289189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.445941ms","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-03-17T22:16:14.289247Z","caller":"traceutil/trace.go:171","msg":"trace[1326929065] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6f686f9ddc-lvtsh.189dc0bed1b3e0f0; range_end:; response_count:1; response_revision:7933; }","duration":"239.659309ms","start":"2026-03-17T22:16:14.049565Z","end":"2026-03-17T22:16:14.289225Z","steps":["trace[1326929065] 'agreement among raft nodes before linearized reading'  (duration: 239.537326ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.289232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.282018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:16:14.289275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.193314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T22:16:14.289323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.266245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:16:14.289344Z","caller":"traceutil/trace.go:171","msg":"trace[78848714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7933; }","duration":"234.298106ms","start":"2026-03-17T22:16:14.05504Z","end":"2026-03-17T22:16:14.289338Z","steps":["trace[78848714] 'agreement among raft nodes before linearized reading'  (duration: 234.250145ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:14.28932Z","caller":"traceutil/trace.go:171","msg":"trace[1024422944] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:7933; }","duration":"338.39329ms","start":"2026-03-17T22:16:13.950906Z","end":"2026-03-17T22:16:14.289299Z","steps":["trace[1024422944] 'agreement among raft nodes before linearized reading'  (duration: 338.248676ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:14.28935Z","caller":"traceutil/trace.go:171","msg":"trace[2017222631] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:7933; }","duration":"403.305897ms","start":"2026-03-17T22:16:13.886025Z","end":"2026-03-17T22:16:14.289331Z","steps":["trace[2017222631] 'agreement among raft nodes before linearized reading'  (duration: 403.162053ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:14.289061Z","caller":"traceutil/trace.go:171","msg":"trace[2105933171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7933; }","duration":"300.277801ms","start":"2026-03-17T22:16:13.988749Z","end":"2026-03-17T22:16:14.289027Z","steps":["trace[2105933171] 'agreement among raft nodes before linearized reading'  (duration: 299.982143ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.289404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.950895Z","time spent":"338.491862ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:16:14.289404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.885991Z","time spent":"403.397059ms","remote":"127.0.0.1:34278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":29,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:16:14.28943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.98874Z","time spent":"300.670301ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T22:16:14.289255Z","caller":"traceutil/trace.go:171","msg":"trace[1721653389] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7933; }","duration":"455.557984ms","start":"2026-03-17T22:16:13.83368Z","end":"2026-03-17T22:16:14.289238Z","steps":["trace[1721653389] 'agreement among raft nodes before linearized reading'  (duration: 455.342839ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:14.289212Z","caller":"traceutil/trace.go:171","msg":"trace[2082863064] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:7933; }","duration":"155.517019ms","start":"2026-03-17T22:16:14.133674Z","end":"2026-03-17T22:16:14.289191Z","steps":["trace[2082863064] 'agreement among raft nodes before linearized reading'  (duration: 155.194761ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:14.289211Z","caller":"traceutil/trace.go:171","msg":"trace[560486407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7933; }","duration":"577.706771ms","start":"2026-03-17T22:16:13.711494Z","end":"2026-03-17T22:16:14.289201Z","steps":["trace[560486407] 'agreement among raft nodes before linearized reading'  (duration: 577.619669ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.289503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.833662Z","time spent":"455.832471ms","remote":"127.0.0.1:35568","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-03-17T22:16:14.289532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.711482Z","time spent":"578.03175ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-17T22:16:14.289094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.770484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-17T22:16:14.289663Z","caller":"traceutil/trace.go:171","msg":"trace[1395966162] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:7933; }","duration":"516.36639ms","start":"2026-03-17T22:16:13.77328Z","end":"2026-03-17T22:16:14.289646Z","steps":["trace[1395966162] 'agreement among raft nodes before linearized reading'  (duration: 515.737464ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.289724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.773256Z","time spent":"516.452653ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-x2znm\" "}
{"level":"info","ts":"2026-03-17T22:16:14.288987Z","caller":"traceutil/trace.go:171","msg":"trace[636096518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7933; }","duration":"579.320664ms","start":"2026-03-17T22:16:13.709643Z","end":"2026-03-17T22:16:14.288964Z","steps":["trace[636096518] 'agreement among raft nodes before linearized reading'  (duration: 579.080398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.289839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.709632Z","time spent":"580.194908ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-17T22:16:14.289627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.810154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-03-17T22:16:14.290299Z","caller":"traceutil/trace.go:171","msg":"trace[474113309] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7933; }","duration":"578.555084ms","start":"2026-03-17T22:16:13.71173Z","end":"2026-03-17T22:16:14.290285Z","steps":["trace[474113309] 'agreement among raft nodes before linearized reading'  (duration: 577.388233ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:14.290329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:13.711719Z","time spent":"578.599255ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-03-17T22:16:14.536363Z","caller":"traceutil/trace.go:171","msg":"trace[1502981601] transaction","detail":"{read_only:false; response_revision:7942; number_of_response:1; }","duration":"120.77937ms","start":"2026-03-17T22:16:14.415539Z","end":"2026-03-17T22:16:14.536318Z","steps":["trace[1502981601] 'process raft request'  (duration: 69.299243ms)","trace[1502981601] 'compare'  (duration: 51.322543ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:16.464455Z","caller":"traceutil/trace.go:171","msg":"trace[2017130159] transaction","detail":"{read_only:false; response_revision:7945; number_of_response:1; }","duration":"160.337949ms","start":"2026-03-17T22:16:16.304095Z","end":"2026-03-17T22:16:16.464433Z","steps":["trace[2017130159] 'process raft request'  (duration: 160.175554ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:16.604634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.893263ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281499552 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:7934 > 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:16"}
{"level":"info","ts":"2026-03-17T22:16:16.604969Z","caller":"traceutil/trace.go:171","msg":"trace[1642038127] transaction","detail":"{read_only:false; response_revision:7947; number_of_response:1; }","duration":"193.963728ms","start":"2026-03-17T22:16:16.410969Z","end":"2026-03-17T22:16:16.604932Z","steps":["trace[1642038127] 'process raft request'  (duration: 193.776243ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:16.605056Z","caller":"traceutil/trace.go:171","msg":"trace[1968981389] transaction","detail":"{read_only:false; response_revision:7946; number_of_response:1; }","duration":"297.395985ms","start":"2026-03-17T22:16:16.307634Z","end":"2026-03-17T22:16:16.60503Z","steps":["trace[1968981389] 'process raft request'  (duration: 190.991319ms)","trace[1968981389] 'compare'  (duration: 105.733018ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:16.605007Z","caller":"traceutil/trace.go:171","msg":"trace[2012838690] linearizableReadLoop","detail":"{readStateIndex:8236; appliedIndex:8234; }","duration":"221.673609ms","start":"2026-03-17T22:16:16.383305Z","end":"2026-03-17T22:16:16.604978Z","steps":["trace[2012838690] 'read index received'  (duration: 80.992516ms)","trace[2012838690] 'applied index is now lower than readState.Index'  (duration: 140.678003ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:16:16.605352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.043259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-17T22:16:16.605373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.8648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-17T22:16:16.60542Z","caller":"traceutil/trace.go:171","msg":"trace[1351268956] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:7948; }","duration":"216.933203ms","start":"2026-03-17T22:16:16.388473Z","end":"2026-03-17T22:16:16.605406Z","steps":["trace[1351268956] 'agreement among raft nodes before linearized reading'  (duration: 216.800339ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:16.605403Z","caller":"traceutil/trace.go:171","msg":"trace[464731403] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7948; }","duration":"222.135891ms","start":"2026-03-17T22:16:16.383255Z","end":"2026-03-17T22:16:16.605391Z","steps":["trace[464731403] 'agreement among raft nodes before linearized reading'  (duration: 221.956356ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:16.605373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.862524ms","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-03-17T22:16:16.605533Z","caller":"traceutil/trace.go:171","msg":"trace[1519286135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7948; }","duration":"222.06787ms","start":"2026-03-17T22:16:16.383448Z","end":"2026-03-17T22:16:16.605515Z","steps":["trace[1519286135] 'agreement among raft nodes before linearized reading'  (duration: 221.816943ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:16.605555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.488494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T22:16:16.605732Z","caller":"traceutil/trace.go:171","msg":"trace[279307791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7948; }","duration":"221.68509ms","start":"2026-03-17T22:16:16.384035Z","end":"2026-03-17T22:16:16.60572Z","steps":["trace[279307791] 'agreement among raft nodes before linearized reading'  (duration: 221.340441ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:16.90567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.448637ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281499558 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:7937 > 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:16"}
{"level":"info","ts":"2026-03-17T22:16:16.90589Z","caller":"traceutil/trace.go:171","msg":"trace[418985087] transaction","detail":"{read_only:false; response_revision:7951; number_of_response:1; }","duration":"295.091603ms","start":"2026-03-17T22:16:16.610783Z","end":"2026-03-17T22:16:16.905875Z","steps":["trace[418985087] 'process raft request'  (duration: 295.042791ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:16.905928Z","caller":"traceutil/trace.go:171","msg":"trace[1386335013] transaction","detail":"{read_only:false; response_revision:7949; number_of_response:1; }","duration":"296.08998ms","start":"2026-03-17T22:16:16.609802Z","end":"2026-03-17T22:16:16.905892Z","steps":["trace[1386335013] 'process raft request'  (duration: 158.337506ms)","trace[1386335013] 'compare'  (duration: 137.324153ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:16.906082Z","caller":"traceutil/trace.go:171","msg":"trace[472830583] transaction","detail":"{read_only:false; response_revision:7950; number_of_response:1; }","duration":"295.502904ms","start":"2026-03-17T22:16:16.61057Z","end":"2026-03-17T22:16:16.906073Z","steps":["trace[472830583] 'process raft request'  (duration: 295.208176ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:18.717851Z","caller":"traceutil/trace.go:171","msg":"trace[509522417] transaction","detail":"{read_only:false; response_revision:7954; number_of_response:1; }","duration":"194.04033ms","start":"2026-03-17T22:16:18.523786Z","end":"2026-03-17T22:16:18.717827Z","steps":["trace[509522417] 'process raft request'  (duration: 193.718261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:18.749744Z","caller":"traceutil/trace.go:171","msg":"trace[774982271] linearizableReadLoop","detail":"{readStateIndex:8245; appliedIndex:8243; }","duration":"140.822497ms","start":"2026-03-17T22:16:18.608901Z","end":"2026-03-17T22:16:18.749723Z","steps":["trace[774982271] 'read index received'  (duration: 108.473682ms)","trace[774982271] 'applied index is now lower than readState.Index'  (duration: 32.347745ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:18.749852Z","caller":"traceutil/trace.go:171","msg":"trace[171654667] transaction","detail":"{read_only:false; response_revision:7956; number_of_response:1; }","duration":"138.593018ms","start":"2026-03-17T22:16:18.611221Z","end":"2026-03-17T22:16:18.749814Z","steps":["trace[171654667] 'process raft request'  (duration: 138.425613ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:18.749898Z","caller":"traceutil/trace.go:171","msg":"trace[954156407] transaction","detail":"{read_only:false; response_revision:7955; number_of_response:1; }","duration":"138.994638ms","start":"2026-03-17T22:16:18.610863Z","end":"2026-03-17T22:16:18.749857Z","steps":["trace[954156407] 'process raft request'  (duration: 138.628268ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:18.750134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.210677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-17T22:16:18.75011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.628914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-17T22:16:18.750217Z","caller":"traceutil/trace.go:171","msg":"trace[527356523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7957; }","duration":"141.342571ms","start":"2026-03-17T22:16:18.608857Z","end":"2026-03-17T22:16:18.7502Z","steps":["trace[527356523] 'agreement among raft nodes before linearized reading'  (duration: 141.092754ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:18.750301Z","caller":"traceutil/trace.go:171","msg":"trace[314820352] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:7957; }","duration":"133.876241ms","start":"2026-03-17T22:16:18.616404Z","end":"2026-03-17T22:16:18.75028Z","steps":["trace[314820352] 'agreement among raft nodes before linearized reading'  (duration: 133.508881ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:42.628435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.774953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.149\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-17T22:16:42.628535Z","caller":"traceutil/trace.go:171","msg":"trace[1159385421] range","detail":"{range_begin:/registry/masterleases/199.204.45.149; range_end:; response_count:1; response_revision:8120; }","duration":"156.940018ms","start":"2026-03-17T22:16:42.471574Z","end":"2026-03-17T22:16:42.628514Z","steps":["trace[1159385421] 'range keys from in-memory index tree'  (duration: 156.512516ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:42.628639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.393547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/rook-ceph/csi-rbdplugin-metrics\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:16:42.628953Z","caller":"traceutil/trace.go:171","msg":"trace[680875788] range","detail":"{range_begin:/registry/services/specs/rook-ceph/csi-rbdplugin-metrics; range_end:; response_count:0; response_revision:8120; }","duration":"127.542441ms","start":"2026-03-17T22:16:42.501194Z","end":"2026-03-17T22:16:42.628736Z","steps":["trace[680875788] 'range keys from in-memory index tree'  (duration: 127.11953ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:46.474929Z","caller":"traceutil/trace.go:171","msg":"trace[404782943] linearizableReadLoop","detail":"{readStateIndex:8443; appliedIndex:8442; }","duration":"415.636956ms","start":"2026-03-17T22:16:46.059266Z","end":"2026-03-17T22:16:46.474903Z","steps":["trace[404782943] 'read index received'  (duration: 415.42056ms)","trace[404782943] 'applied index is now lower than readState.Index'  (duration: 214.946µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:46.475026Z","caller":"traceutil/trace.go:171","msg":"trace[1346130226] transaction","detail":"{read_only:false; response_revision:8144; number_of_response:1; }","duration":"467.467542ms","start":"2026-03-17T22:16:46.007526Z","end":"2026-03-17T22:16:46.474993Z","steps":["trace[1346130226] 'process raft request'  (duration: 467.217556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:46.475157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.322463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T22:16:46.475173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:46.007495Z","time spent":"467.602726ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":461,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8132 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-17T22:16:46.475202Z","caller":"traceutil/trace.go:171","msg":"trace[555197388] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8144; }","duration":"386.430216ms","start":"2026-03-17T22:16:46.088758Z","end":"2026-03-17T22:16:46.475188Z","steps":["trace[555197388] 'agreement among raft nodes before linearized reading'  (duration: 386.326103ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:46.475257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:46.088738Z","time spent":"386.507147ms","remote":"127.0.0.1:54406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":2,"response size":31,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:16:46.47519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.475412ms","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-03-17T22:16:46.47555Z","caller":"traceutil/trace.go:171","msg":"trace[1548762168] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8144; }","duration":"415.850162ms","start":"2026-03-17T22:16:46.059651Z","end":"2026-03-17T22:16:46.475501Z","steps":["trace[1548762168] 'agreement among raft nodes before linearized reading'  (duration: 415.436671ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:46.47569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:46.059642Z","time spent":"415.960785ms","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:16:46.476118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.791298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:16:46.476177Z","caller":"traceutil/trace.go:171","msg":"trace[1183279927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8144; }","duration":"416.942182ms","start":"2026-03-17T22:16:46.059221Z","end":"2026-03-17T22:16:46.476164Z","steps":["trace[1183279927] 'agreement among raft nodes before linearized reading'  (duration: 415.820862ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:46.476323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:46.059194Z","time spent":"417.117266ms","remote":"127.0.0.1:35364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-17T22:16:49.040641Z","caller":"traceutil/trace.go:171","msg":"trace[1547163481] transaction","detail":"{read_only:false; response_revision:8154; number_of_response:1; }","duration":"197.991426ms","start":"2026-03-17T22:16:48.842628Z","end":"2026-03-17T22:16:49.040619Z","steps":["trace[1547163481] 'process raft request'  (duration: 197.845032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:49.374931Z","caller":"traceutil/trace.go:171","msg":"trace[1729052883] linearizableReadLoop","detail":"{readStateIndex:8456; appliedIndex:8453; }","duration":"466.647962ms","start":"2026-03-17T22:16:48.908256Z","end":"2026-03-17T22:16:49.374904Z","steps":["trace[1729052883] 'read index received'  (duration: 132.253688ms)","trace[1729052883] 'applied index is now lower than readState.Index'  (duration: 334.392874ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:49.37534Z","caller":"traceutil/trace.go:171","msg":"trace[767178877] transaction","detail":"{read_only:false; response_revision:8155; number_of_response:1; }","duration":"508.663005ms","start":"2026-03-17T22:16:48.866655Z","end":"2026-03-17T22:16:49.375318Z","steps":["trace[767178877] 'process raft request'  (duration: 451.888647ms)","trace[767178877] 'compare'  (duration: 56.112611ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:16:49.375383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.114254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-17T22:16:49.375419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.178264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-03-17T22:16:49.375452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:48.866627Z","time spent":"508.769398ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8146 > 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-03-17T22:16:49.375467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.868822ms","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-03-17T22:16:49.375473Z","caller":"traceutil/trace.go:171","msg":"trace[628936213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8156; }","duration":"467.269508ms","start":"2026-03-17T22:16:48.908184Z","end":"2026-03-17T22:16:49.375454Z","steps":["trace[628936213] 'agreement among raft nodes before linearized reading'  (duration: 466.98318ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:49.375477Z","caller":"traceutil/trace.go:171","msg":"trace[816234533] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:8156; }","duration":"437.286486ms","start":"2026-03-17T22:16:48.938176Z","end":"2026-03-17T22:16:49.375462Z","steps":["trace[816234533] 'agreement among raft nodes before linearized reading'  (duration: 437.06911ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:49.375475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.198034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-17T22:16:49.375516Z","caller":"traceutil/trace.go:171","msg":"trace[1788876375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8156; }","duration":"231.926783ms","start":"2026-03-17T22:16:49.143574Z","end":"2026-03-17T22:16:49.375501Z","steps":["trace[1788876375] 'agreement among raft nodes before linearized reading'  (duration: 231.738538ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:49.375521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:48.908154Z","time spent":"467.356831ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-17T22:16:49.375495Z","caller":"traceutil/trace.go:171","msg":"trace[1791261929] transaction","detail":"{read_only:false; response_revision:8156; number_of_response:1; }","duration":"498.169355ms","start":"2026-03-17T22:16:48.877289Z","end":"2026-03-17T22:16:49.375458Z","steps":["trace[1791261929] 'process raft request'  (duration: 497.557309ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:49.375533Z","caller":"traceutil/trace.go:171","msg":"trace[401727339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8156; }","duration":"237.294997ms","start":"2026-03-17T22:16:49.13822Z","end":"2026-03-17T22:16:49.375515Z","steps":["trace[401727339] 'agreement among raft nodes before linearized reading'  (duration: 237.099241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:49.375529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.269591ms","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-03-17T22:16:49.3756Z","caller":"traceutil/trace.go:171","msg":"trace[1598378392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8156; }","duration":"214.360363ms","start":"2026-03-17T22:16:49.161222Z","end":"2026-03-17T22:16:49.375582Z","steps":["trace[1598378392] 'agreement among raft nodes before linearized reading'  (duration: 214.094776ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:49.375521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:48.938148Z","time spent":"437.364809ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-x2znm\" "}
{"level":"warn","ts":"2026-03-17T22:16:49.375667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:48.877248Z","time spent":"498.332429ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8147 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-17T22:16:59.940213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.62974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281500488 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8224 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:16:59.94085Z","caller":"traceutil/trace.go:171","msg":"trace[1356820806] linearizableReadLoop","detail":"{readStateIndex:8551; appliedIndex:8550; }","duration":"506.30118ms","start":"2026-03-17T22:16:59.434515Z","end":"2026-03-17T22:16:59.940816Z","steps":["trace[1356820806] 'read index received'  (duration: 108.999501ms)","trace[1356820806] 'applied index is now lower than readState.Index'  (duration: 397.297459ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:59.940867Z","caller":"traceutil/trace.go:171","msg":"trace[1656737932] transaction","detail":"{read_only:false; response_revision:8246; number_of_response:1; }","duration":"523.117789ms","start":"2026-03-17T22:16:59.417664Z","end":"2026-03-17T22:16:59.940781Z","steps":["trace[1656737932] 'process raft request'  (duration: 125.81296ms)","trace[1656737932] 'compare'  (duration: 396.467586ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:16:59.940964Z","caller":"traceutil/trace.go:171","msg":"trace[1425193774] transaction","detail":"{read_only:false; response_revision:8247; number_of_response:1; }","duration":"445.053883ms","start":"2026-03-17T22:16:59.495867Z","end":"2026-03-17T22:16:59.940921Z","steps":["trace[1425193774] 'process raft request'  (duration: 444.451267ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.41765Z","time spent":"523.343724ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8224 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-17T22:16:59.941166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.639238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-17T22:16:59.941169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.185817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-03-17T22:16:59.941219Z","caller":"traceutil/trace.go:171","msg":"trace[1311337711] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8247; }","duration":"506.739761ms","start":"2026-03-17T22:16:59.434465Z","end":"2026-03-17T22:16:59.941205Z","steps":["trace[1311337711] 'agreement among raft nodes before linearized reading'  (duration: 506.542396ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:16:59.94123Z","caller":"traceutil/trace.go:171","msg":"trace[1565581322] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8247; }","duration":"315.273548ms","start":"2026-03-17T22:16:59.625938Z","end":"2026-03-17T22:16:59.941212Z","steps":["trace[1565581322] 'agreement among raft nodes before linearized reading'  (duration: 315.076383ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.209196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-17T22:16:59.941266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.434416Z","time spent":"506.841863ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-17T22:16:59.941061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.495843Z","time spent":"445.172577ms","remote":"127.0.0.1:35628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8238 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"info","ts":"2026-03-17T22:16:59.941323Z","caller":"traceutil/trace.go:171","msg":"trace[1440973176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8247; }","duration":"482.33947ms","start":"2026-03-17T22:16:59.458966Z","end":"2026-03-17T22:16:59.941306Z","steps":["trace[1440973176] 'agreement among raft nodes before linearized reading'  (duration: 482.052372ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.626644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-17T22:16:59.941268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.625924Z","time spent":"315.33583ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-03-17T22:16:59.941383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.458953Z","time spent":"482.420612ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-17T22:16:59.941404Z","caller":"traceutil/trace.go:171","msg":"trace[462809928] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8247; }","duration":"477.794969ms","start":"2026-03-17T22:16:59.463583Z","end":"2026-03-17T22:16:59.941378Z","steps":["trace[462809928] 'agreement among raft nodes before linearized reading'  (duration: 477.46421ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.379847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-03-17T22:16:59.941456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.463558Z","time spent":"477.88791ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T22:16:59.941506Z","caller":"traceutil/trace.go:171","msg":"trace[1236347390] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:8247; }","duration":"474.672295ms","start":"2026-03-17T22:16:59.466813Z","end":"2026-03-17T22:16:59.941486Z","steps":["trace[1236347390] 'agreement among raft nodes before linearized reading'  (duration: 474.268574ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.466803Z","time spent":"474.735447ms","remote":"127.0.0.1:35568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-x2znm\" "}
{"level":"warn","ts":"2026-03-17T22:16:59.941218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.189581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"info","ts":"2026-03-17T22:16:59.941614Z","caller":"traceutil/trace.go:171","msg":"trace[1663605082] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8247; }","duration":"168.608582ms","start":"2026-03-17T22:16:59.772972Z","end":"2026-03-17T22:16:59.94158Z","steps":["trace[1663605082] 'agreement among raft nodes before linearized reading'  (duration: 168.039847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.338513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T22:16:59.941801Z","caller":"traceutil/trace.go:171","msg":"trace[848493778] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8247; }","duration":"478.535058ms","start":"2026-03-17T22:16:59.463245Z","end":"2026-03-17T22:16:59.94178Z","steps":["trace[848493778] 'agreement among raft nodes before linearized reading'  (duration: 477.8349ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:16:59.941903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:16:59.463232Z","time spent":"478.653191ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-17T22:17:01.078579Z","caller":"traceutil/trace.go:171","msg":"trace[1910498992] linearizableReadLoop","detail":"{readStateIndex:8563; appliedIndex:8562; }","duration":"264.81278ms","start":"2026-03-17T22:17:00.813726Z","end":"2026-03-17T22:17:01.078539Z","steps":["trace[1910498992] 'read index received'  (duration: 234.349127ms)","trace[1910498992] 'applied index is now lower than readState.Index'  (duration: 30.461573ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:17:01.078769Z","caller":"traceutil/trace.go:171","msg":"trace[951417557] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"380.853909ms","start":"2026-03-17T22:17:00.697881Z","end":"2026-03-17T22:17:01.078734Z","steps":["trace[951417557] 'process raft request'  (duration: 350.177279ms)","trace[951417557] 'compare'  (duration: 29.813537ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:17:01.078947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:17:00.697842Z","time spent":"381.017053ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8234 > 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-03-17T22:17:01.079053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.253393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:17:01.079149Z","caller":"traceutil/trace.go:171","msg":"trace[111685732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8258; }","duration":"265.460438ms","start":"2026-03-17T22:17:00.813674Z","end":"2026-03-17T22:17:01.079135Z","steps":["trace[111685732] 'agreement among raft nodes before linearized reading'  (duration: 265.16615ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:01.279969Z","caller":"traceutil/trace.go:171","msg":"trace[794873812] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"189.541261ms","start":"2026-03-17T22:17:01.090392Z","end":"2026-03-17T22:17:01.279934Z","steps":["trace[794873812] 'process raft request'  (duration: 114.355393ms)","trace[794873812] 'compare'  (duration: 74.790007ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:17:01.556622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.080742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-03-17T22:17:01.556776Z","caller":"traceutil/trace.go:171","msg":"trace[697914238] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8259; }","duration":"161.297287ms","start":"2026-03-17T22:17:01.395442Z","end":"2026-03-17T22:17:01.556739Z","steps":["trace[697914238] 'range keys from in-memory index tree'  (duration: 160.600728ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:01.593063Z","caller":"traceutil/trace.go:171","msg":"trace[1152659766] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"169.327861ms","start":"2026-03-17T22:17:01.4237Z","end":"2026-03-17T22:17:01.593028Z","steps":["trace[1152659766] 'process raft request'  (duration: 168.828477ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:12.249924Z","caller":"traceutil/trace.go:171","msg":"trace[715085722] linearizableReadLoop","detail":"{readStateIndex:8652; appliedIndex:8651; }","duration":"172.536067ms","start":"2026-03-17T22:17:12.077349Z","end":"2026-03-17T22:17:12.249885Z","steps":["trace[715085722] 'read index received'  (duration: 172.153097ms)","trace[715085722] 'applied index is now lower than readState.Index'  (duration: 381.33µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:17:12.250038Z","caller":"traceutil/trace.go:171","msg":"trace[2020818401] transaction","detail":"{read_only:false; response_revision:8344; number_of_response:1; }","duration":"187.222809ms","start":"2026-03-17T22:17:12.062772Z","end":"2026-03-17T22:17:12.249995Z","steps":["trace[2020818401] 'process raft request'  (duration: 186.86075ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:17:12.250257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.867456ms","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-03-17T22:17:12.250302Z","caller":"traceutil/trace.go:171","msg":"trace[1871142051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8344; }","duration":"172.985469ms","start":"2026-03-17T22:17:12.077303Z","end":"2026-03-17T22:17:12.250288Z","steps":["trace[1871142051] 'agreement among raft nodes before linearized reading'  (duration: 172.782924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:17:12.250377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.245855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x2znm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-03-17T22:17:12.250477Z","caller":"traceutil/trace.go:171","msg":"trace[144079464] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x2znm; range_end:; response_count:1; response_revision:8344; }","duration":"158.329607ms","start":"2026-03-17T22:17:12.09208Z","end":"2026-03-17T22:17:12.25041Z","steps":["trace[144079464] 'agreement among raft nodes before linearized reading'  (duration: 158.096611ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:17:12.250461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.610092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-17T22:17:12.25051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.229422ms","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-03-17T22:17:12.250549Z","caller":"traceutil/trace.go:171","msg":"trace[1150413231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8344; }","duration":"171.774937ms","start":"2026-03-17T22:17:12.078754Z","end":"2026-03-17T22:17:12.250529Z","steps":["trace[1150413231] 'agreement among raft nodes before linearized reading'  (duration: 171.406127ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:12.250605Z","caller":"traceutil/trace.go:171","msg":"trace[923113014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8344; }","duration":"171.344325ms","start":"2026-03-17T22:17:12.079239Z","end":"2026-03-17T22:17:12.250583Z","steps":["trace[923113014] 'agreement among raft nodes before linearized reading'  (duration: 170.999096ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:32.476143Z","caller":"traceutil/trace.go:171","msg":"trace[1586234620] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"112.175475ms","start":"2026-03-17T22:17:32.363943Z","end":"2026-03-17T22:17:32.476119Z","steps":["trace[1586234620] 'process raft request'  (duration: 80.480819ms)","trace[1586234620] 'compare'  (duration: 31.535952ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:17:32.476454Z","caller":"traceutil/trace.go:171","msg":"trace[1536234435] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"111.20884ms","start":"2026-03-17T22:17:32.365221Z","end":"2026-03-17T22:17:32.47643Z","steps":["trace[1536234435] 'process raft request'  (duration: 110.86774ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:32.476497Z","caller":"traceutil/trace.go:171","msg":"trace[914185131] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"111.015275ms","start":"2026-03-17T22:17:32.365455Z","end":"2026-03-17T22:17:32.476471Z","steps":["trace[914185131] 'process raft request'  (duration: 110.870951ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:17:42.700924Z","caller":"traceutil/trace.go:171","msg":"trace[2129495600] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"123.680742ms","start":"2026-03-17T22:17:42.577215Z","end":"2026-03-17T22:17:42.700896Z","steps":["trace[2129495600] 'process raft request'  (duration: 123.390715ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:17.938941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.13532ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2594527474281502530 > lease_revoke:<id:24019cfdd08a5655>","response":"size:29"}
{"level":"info","ts":"2026-03-17T22:18:17.999281Z","caller":"traceutil/trace.go:171","msg":"trace[286455803] transaction","detail":"{read_only:false; response_revision:8968; number_of_response:1; }","duration":"124.271028ms","start":"2026-03-17T22:18:17.874989Z","end":"2026-03-17T22:18:17.99926Z","steps":["trace[286455803] 'process raft request'  (duration: 123.957779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:18.281861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.809883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:18:18.281985Z","caller":"traceutil/trace.go:171","msg":"trace[815070106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8968; }","duration":"224.967957ms","start":"2026-03-17T22:18:18.056991Z","end":"2026-03-17T22:18:18.281959Z","steps":["trace[815070106] 'range keys from in-memory index tree'  (duration: 224.749531ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:18.282109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.40507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T22:18:18.282246Z","caller":"traceutil/trace.go:171","msg":"trace[1616659177] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8968; }","duration":"237.579994ms","start":"2026-03-17T22:18:18.04463Z","end":"2026-03-17T22:18:18.28221Z","steps":["trace[1616659177] 'count revisions from in-memory index tree'  (duration: 237.272286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:18.282326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.855474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414497"}
{"level":"info","ts":"2026-03-17T22:18:18.282497Z","caller":"traceutil/trace.go:171","msg":"trace[345532453] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8968; }","duration":"231.03258ms","start":"2026-03-17T22:18:18.051376Z","end":"2026-03-17T22:18:18.282409Z","steps":["trace[345532453] 'range keys from in-memory index tree'  (duration: 230.554856ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:18:18.786413Z","caller":"traceutil/trace.go:171","msg":"trace[1096565561] transaction","detail":"{read_only:false; response_revision:8970; number_of_response:1; }","duration":"175.351922ms","start":"2026-03-17T22:18:18.611026Z","end":"2026-03-17T22:18:18.786377Z","steps":["trace[1096565561] 'process raft request'  (duration: 175.179487ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:18:18.829084Z","caller":"traceutil/trace.go:171","msg":"trace[524595367] linearizableReadLoop","detail":"{readStateIndex:9297; appliedIndex:9295; }","duration":"122.336817ms","start":"2026-03-17T22:18:18.706723Z","end":"2026-03-17T22:18:18.82906Z","steps":["trace[524595367] 'read index received'  (duration: 79.535194ms)","trace[524595367] 'applied index is now lower than readState.Index'  (duration: 42.800973ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:18:18.829128Z","caller":"traceutil/trace.go:171","msg":"trace[659339027] transaction","detail":"{read_only:false; response_revision:8971; number_of_response:1; }","duration":"131.207473ms","start":"2026-03-17T22:18:18.697905Z","end":"2026-03-17T22:18:18.829112Z","steps":["trace[659339027] 'process raft request'  (duration: 127.379311ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:18.829282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.188085ms","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-03-17T22:18:18.829325Z","caller":"traceutil/trace.go:171","msg":"trace[180093776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8971; }","duration":"109.262298ms","start":"2026-03-17T22:18:18.720049Z","end":"2026-03-17T22:18:18.829312Z","steps":["trace[180093776] 'agreement among raft nodes before linearized reading'  (duration: 109.137504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:18.829388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.653795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-17T22:18:18.82956Z","caller":"traceutil/trace.go:171","msg":"trace[1120585847] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8971; }","duration":"122.856301ms","start":"2026-03-17T22:18:18.706682Z","end":"2026-03-17T22:18:18.829539Z","steps":["trace[1120585847] 'agreement among raft nodes before linearized reading'  (duration: 122.493801ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:18:18.963601Z","caller":"traceutil/trace.go:171","msg":"trace[452877499] linearizableReadLoop","detail":"{readStateIndex:9300; appliedIndex:9297; }","duration":"126.991061ms","start":"2026-03-17T22:18:18.836583Z","end":"2026-03-17T22:18:18.963574Z","steps":["trace[452877499] 'read index received'  (duration: 28.197273ms)","trace[452877499] 'applied index is now lower than readState.Index'  (duration: 98.792478ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:18:18.963632Z","caller":"traceutil/trace.go:171","msg":"trace[1734493027] transaction","detail":"{read_only:false; response_revision:8973; number_of_response:1; }","duration":"128.808069ms","start":"2026-03-17T22:18:18.834792Z","end":"2026-03-17T22:18:18.9636Z","steps":["trace[1734493027] 'process raft request'  (duration: 128.533842ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:18:18.96369Z","caller":"traceutil/trace.go:171","msg":"trace[1816631270] transaction","detail":"{read_only:false; response_revision:8974; number_of_response:1; }","duration":"128.106821ms","start":"2026-03-17T22:18:18.835556Z","end":"2026-03-17T22:18:18.963663Z","steps":["trace[1816631270] 'process raft request'  (duration: 127.965847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:18:18.964253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.645988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291542"}
{"level":"info","ts":"2026-03-17T22:18:18.964314Z","caller":"traceutil/trace.go:171","msg":"trace[1072755466] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:8974; }","duration":"127.740051ms","start":"2026-03-17T22:18:18.836562Z","end":"2026-03-17T22:18:18.964302Z","steps":["trace[1072755466] 'agreement among raft nodes before linearized reading'  (duration: 127.123455ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:20:03.00442Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b1b675f124322401","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-17T22:20:03.010004Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-17T22:20:03.01007Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-17T22:20:29.295563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7545}
{"level":"info","ts":"2026-03-17T22:20:29.361095Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7545,"took":"63.330361ms","hash":304399483,"current-db-size-bytes":41807872,"current-db-size":"42 MB","current-db-size-in-use-bytes":25706496,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-17T22:20:29.361155Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":304399483,"revision":7545,"compact-revision":5611}
{"level":"info","ts":"2026-03-17T22:25:29.303762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9890}
{"level":"info","ts":"2026-03-17T22:25:29.385633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9890,"took":"79.700426ms","hash":2994498110,"current-db-size-bytes":41807872,"current-db-size":"42 MB","current-db-size-in-use-bytes":18067456,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-03-17T22:25:29.38585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2994498110,"revision":9890,"compact-revision":7545}