{"level":"warn","ts":"2026-03-11T05:11:51.287952Z","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-11T05:11:51.28804Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-11T05:11:51.288102Z","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-11T05:11:51.28811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]}
{"level":"info","ts":"2026-03-11T05:11:51.28813Z","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-11T05:11:51.288822Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]}
{"level":"info","ts":"2026-03-11T05:11:51.288912Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-11T05:11:51.293691Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.539284ms"}
{"level":"info","ts":"2026-03-11T05:11:51.299752Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"}
{"level":"info","ts":"2026-03-11T05:11:51.299846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-11T05:11:51.299874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"}
{"level":"info","ts":"2026-03-11T05:11:51.299889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-11T05:11:51.2999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"}
{"level":"info","ts":"2026-03-11T05:11:51.299946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"}
{"level":"warn","ts":"2026-03-11T05:11:51.306525Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-11T05:11:51.308007Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-11T05:11:51.309813Z","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-11T05:11:51.312703Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-11T05:11:51.312964Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-11T05:11:51.313245Z","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-11T05:11:51.313342Z","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-11T05:11:51.313363Z","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-11T05:11:51.315673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"}
{"level":"info","ts":"2026-03-11T05:11:51.315786Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]}
{"level":"info","ts":"2026-03-11T05:11:51.317926Z","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-11T05:11:51.318101Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"}
{"level":"info","ts":"2026-03-11T05:11:51.318139Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"}
{"level":"info","ts":"2026-03-11T05:11:51.318417Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-11T05:11:51.318492Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-11T05:11:51.700191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-11T05:11:51.700299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-11T05:11:51.700358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"}
{"level":"info","ts":"2026-03-11T05:11:51.700393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"}
{"level":"info","ts":"2026-03-11T05:11:51.700415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"}
{"level":"info","ts":"2026-03-11T05:11:51.700443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"}
{"level":"info","ts":"2026-03-11T05:11:51.700464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"}
{"level":"info","ts":"2026-03-11T05:11:51.760966Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-11T05:11:51.761022Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-11T05:11:51.761034Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T05:11:51.761207Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-11T05:11:51.761229Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-11T05:11:51.761259Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-11T05:11:51.763701Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-11T05:11:51.770996Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"}
{"level":"info","ts":"2026-03-11T05:11:51.834689Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T05:11:51.834837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T05:11:51.834914Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T05:12:09.085921Z","caller":"traceutil/trace.go:171","msg":"trace[1546567922] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:392; }","duration":"373.970478ms","start":"2026-03-11T05:12:08.711925Z","end":"2026-03-11T05:12:09.085896Z","steps":["trace[1546567922] 'read index received'  (duration: 373.732123ms)","trace[1546567922] 'applied index is now lower than readState.Index'  (duration: 236.895µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:12:09.086049Z","caller":"traceutil/trace.go:171","msg":"trace[722541077] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"385.121814ms","start":"2026-03-11T05:12:08.700889Z","end":"2026-03-11T05:12:09.086011Z","steps":["trace[722541077] 'process raft request'  (duration: 384.857188ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:09.086293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.321067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"}
{"level":"info","ts":"2026-03-11T05:12:09.086437Z","caller":"traceutil/trace.go:171","msg":"trace[799306829] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:378; }","duration":"374.533531ms","start":"2026-03-11T05:12:08.711877Z","end":"2026-03-11T05:12:09.08641Z","steps":["trace[799306829] 'agreement among raft nodes before linearized reading'  (duration: 374.153792ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:09.086497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:08.711851Z","time spent":"374.634743ms","remote":"127.0.0.1:48590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4080,"request content":"key:\"/registry/deployments/kube-system/coredns\" "}
{"level":"warn","ts":"2026-03-11T05:12:09.087145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:08.700867Z","time spent":"385.274628ms","remote":"127.0.0.1:48336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:281 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6673 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-03-11T05:12:09.618129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673541202281432944,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-11T05:12:09.820036Z","caller":"traceutil/trace.go:171","msg":"trace[659436599] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:393; }","duration":"702.875954ms","start":"2026-03-11T05:12:09.117126Z","end":"2026-03-11T05:12:09.820002Z","steps":["trace[659436599] 'read index received'  (duration: 631.377863ms)","trace[659436599] 'applied index is now lower than readState.Index'  (duration: 71.497171ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:12:09.820153Z","caller":"traceutil/trace.go:171","msg":"trace[409241723] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"719.939635ms","start":"2026-03-11T05:12:09.100153Z","end":"2026-03-11T05:12:09.820093Z","steps":["trace[409241723] 'process raft request'  (duration: 648.437894ms)","trace[409241723] 'compare'  (duration: 71.258576ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:12:09.82026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.582915ms","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-11T05:12:09.820327Z","caller":"traceutil/trace.go:171","msg":"trace[541507289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:379; }","duration":"371.718738ms","start":"2026-03-11T05:12:09.448595Z","end":"2026-03-11T05:12:09.820313Z","steps":["trace[541507289] 'agreement among raft nodes before linearized reading'  (duration: 371.572265ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:09.820374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:09.448563Z","time spent":"371.802199ms","remote":"127.0.0.1:48400","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":"warn","ts":"2026-03-11T05:12:09.820426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.828937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:12:09.820526Z","caller":"traceutil/trace.go:171","msg":"trace[1369335613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"118.97948ms","start":"2026-03-11T05:12:09.70152Z","end":"2026-03-11T05:12:09.820499Z","steps":["trace[1369335613] 'agreement among raft nodes before linearized reading'  (duration: 118.801846ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:09.820442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:09.100124Z","time spent":"720.157379ms","remote":"127.0.0.1:48590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:345 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:4131 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"warn","ts":"2026-03-11T05:12:09.820645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.358472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-11T05:12:09.820676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.516298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:12:09.820855Z","caller":"traceutil/trace.go:171","msg":"trace[1858595056] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"703.737653ms","start":"2026-03-11T05:12:09.117077Z","end":"2026-03-11T05:12:09.820815Z","steps":["trace[1858595056] 'agreement among raft nodes before linearized reading'  (duration: 703.085559ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:09.82086Z","caller":"traceutil/trace.go:171","msg":"trace[1815662650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:379; }","duration":"263.603248ms","start":"2026-03-11T05:12:09.557222Z","end":"2026-03-11T05:12:09.820825Z","steps":["trace[1815662650] 'agreement among raft nodes before linearized reading'  (duration: 263.158418ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:09.820923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:09.116436Z","time spent":"704.47373ms","remote":"127.0.0.1:48146","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-11T05:12:10.052337Z","caller":"traceutil/trace.go:171","msg":"trace[329449227] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"132.507509ms","start":"2026-03-11T05:12:09.919803Z","end":"2026-03-11T05:12:10.05231Z","steps":["trace[329449227] 'process raft request'  (duration: 77.779864ms)","trace[329449227] 'compare'  (duration: 54.586792ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:12:10.066511Z","caller":"traceutil/trace.go:171","msg":"trace[1116345852] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"144.758731ms","start":"2026-03-11T05:12:09.921738Z","end":"2026-03-11T05:12:10.066497Z","steps":["trace[1116345852] 'process raft request'  (duration: 144.690499ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:10.066531Z","caller":"traceutil/trace.go:171","msg":"trace[1779831889] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"145.024976ms","start":"2026-03-11T05:12:09.921486Z","end":"2026-03-11T05:12:10.066511Z","steps":["trace[1779831889] 'process raft request'  (duration: 144.891473ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:10.066542Z","caller":"traceutil/trace.go:171","msg":"trace[501818049] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"146.198384ms","start":"2026-03-11T05:12:09.920294Z","end":"2026-03-11T05:12:10.066492Z","steps":["trace[501818049] 'process raft request'  (duration: 146.02338ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:10.066736Z","caller":"traceutil/trace.go:171","msg":"trace[774258354] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"144.71087ms","start":"2026-03-11T05:12:09.922017Z","end":"2026-03-11T05:12:10.066728Z","steps":["trace[774258354] 'process raft request'  (duration: 144.449604ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:10.210488Z","caller":"traceutil/trace.go:171","msg":"trace[469728439] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:408; }","duration":"108.194862ms","start":"2026-03-11T05:12:10.102243Z","end":"2026-03-11T05:12:10.210438Z","steps":["trace[469728439] 'read index received'  (duration: 67.856737ms)","trace[469728439] 'applied index is now lower than readState.Index'  (duration: 40.336505ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:12:10.210648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.399067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"}
{"level":"info","ts":"2026-03-11T05:12:10.210694Z","caller":"traceutil/trace.go:171","msg":"trace[1988771613] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:394; }","duration":"108.469258ms","start":"2026-03-11T05:12:10.102212Z","end":"2026-03-11T05:12:10.210682Z","steps":["trace[1988771613] 'agreement among raft nodes before linearized reading'  (duration: 108.370076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:10.210932Z","caller":"traceutil/trace.go:171","msg":"trace[2126049355] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"128.821334ms","start":"2026-03-11T05:12:10.082041Z","end":"2026-03-11T05:12:10.210862Z","steps":["trace[2126049355] 'process raft request'  (duration: 87.974378ms)","trace[2126049355] 'compare'  (duration: 40.288264ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:12:10.211247Z","caller":"traceutil/trace.go:171","msg":"trace[1118216271] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"105.222203ms","start":"2026-03-11T05:12:10.106005Z","end":"2026-03-11T05:12:10.211227Z","steps":["trace[1118216271] 'process raft request'  (duration: 105.08855ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:30.462525Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673541202281433206,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-11T05:12:30.488254Z","caller":"traceutil/trace.go:171","msg":"trace[1985759292] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"574.787493ms","start":"2026-03-11T05:12:29.913438Z","end":"2026-03-11T05:12:30.488225Z","steps":["trace[1985759292] 'process raft request'  (duration: 574.589438ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:30.488454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:29.913419Z","time spent":"574.926796ms","remote":"127.0.0.1:48336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-fhtsb\" mod_revision:465 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-fhtsb\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-fhtsb\" > >"}
{"level":"info","ts":"2026-03-11T05:12:30.618683Z","caller":"traceutil/trace.go:171","msg":"trace[1676703739] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:533; }","duration":"656.352454ms","start":"2026-03-11T05:12:29.962302Z","end":"2026-03-11T05:12:30.618655Z","steps":["trace[1676703739] 'read index received'  (duration: 525.770471ms)","trace[1676703739] 'applied index is now lower than readState.Index'  (duration: 130.580203ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:12:30.618991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.63881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-11T05:12:30.619036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.491926ms","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-11T05:12:30.619081Z","caller":"traceutil/trace.go:171","msg":"trace[535178701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"436.593298ms","start":"2026-03-11T05:12:30.182476Z","end":"2026-03-11T05:12:30.61907Z","steps":["trace[535178701] 'agreement among raft nodes before linearized reading'  (duration: 436.387684ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:12:30.619085Z","caller":"traceutil/trace.go:171","msg":"trace[242216260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"656.785344ms","start":"2026-03-11T05:12:29.962279Z","end":"2026-03-11T05:12:30.619065Z","steps":["trace[242216260] 'agreement among raft nodes before linearized reading'  (duration: 656.487567ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:30.619079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.80684ms","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-11T05:12:30.619117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:30.182457Z","time spent":"436.651849ms","remote":"127.0.0.1:48400","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-11T05:12:30.619134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:29.962269Z","time spent":"656.856155ms","remote":"127.0.0.1:48400","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-11T05:12:30.61916Z","caller":"traceutil/trace.go:171","msg":"trace[901758458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"634.940663ms","start":"2026-03-11T05:12:29.984194Z","end":"2026-03-11T05:12:30.619135Z","steps":["trace[901758458] 'agreement among raft nodes before linearized reading'  (duration: 634.674457ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:30.619196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.826488ms","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-11T05:12:30.619278Z","caller":"traceutil/trace.go:171","msg":"trace[1383277083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"633.94744ms","start":"2026-03-11T05:12:29.985309Z","end":"2026-03-11T05:12:30.619256Z","steps":["trace[1383277083] 'agreement among raft nodes before linearized reading'  (duration: 633.673574ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:30.619321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:29.985294Z","time spent":"634.019192ms","remote":"127.0.0.1:48400","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-11T05:12:30.619322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:29.98417Z","time spent":"635.135817ms","remote":"127.0.0.1:48400","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-11T05:12:32.174065Z","caller":"traceutil/trace.go:171","msg":"trace[2135383400] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"134.154474ms","start":"2026-03-11T05:12:32.039874Z","end":"2026-03-11T05:12:32.174029Z","steps":["trace[2135383400] 'process raft request'  (duration: 133.259814ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:12:49.586015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.945545ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541202281433862 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" mod_revision:505 > success:<request_put:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" value_size:3216 >> failure:<request_range:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T05:12:49.586145Z","caller":"traceutil/trace.go:171","msg":"trace[770174605] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"506.407757ms","start":"2026-03-11T05:12:49.079717Z","end":"2026-03-11T05:12:49.586125Z","steps":["trace[770174605] 'process raft request'  (duration: 370.097974ms)","trace[770174605] 'compare'  (duration: 135.805532ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:12:49.586215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:12:49.079688Z","time spent":"506.494938ms","remote":"127.0.0.1:48604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3297,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" mod_revision:505 > success:<request_put:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" value_size:3216 >> failure:<request_range:<key:\"/registry/replicasets/local-path-storage/local-path-provisioner-679c578f5\" > >"}
{"level":"info","ts":"2026-03-11T05:13:18.656532Z","caller":"traceutil/trace.go:171","msg":"trace[2079160314] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"377.274616ms","start":"2026-03-11T05:13:18.279229Z","end":"2026-03-11T05:13:18.656503Z","steps":["trace[2079160314] 'process raft request'  (duration: 377.104202ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:18.656703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:18.279203Z","time spent":"377.412508ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1162 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-11T05:13:41.600177Z","caller":"traceutil/trace.go:171","msg":"trace[718549437] linearizableReadLoop","detail":"{readStateIndex:1630; appliedIndex:1629; }","duration":"412.403829ms","start":"2026-03-11T05:13:41.187746Z","end":"2026-03-11T05:13:41.600149Z","steps":["trace[718549437] 'read index received'  (duration: 412.219655ms)","trace[718549437] 'applied index is now lower than readState.Index'  (duration: 182.634µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:13:41.600234Z","caller":"traceutil/trace.go:171","msg":"trace[2078497367] transaction","detail":"{read_only:false; response_revision:1569; number_of_response:1; }","duration":"413.490913ms","start":"2026-03-11T05:13:41.186709Z","end":"2026-03-11T05:13:41.6002Z","steps":["trace[2078497367] 'process raft request'  (duration: 413.254918ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:41.600477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:41.186685Z","time spent":"413.640196ms","remote":"127.0.0.1:48400","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:1516 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-11T05:13:41.600526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.756556ms","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-11T05:13:41.600633Z","caller":"traceutil/trace.go:171","msg":"trace[2043714068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1569; }","duration":"412.882699ms","start":"2026-03-11T05:13:41.187727Z","end":"2026-03-11T05:13:41.60061Z","steps":["trace[2043714068] 'agreement among raft nodes before linearized reading'  (duration: 412.612723ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:41.600639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.803583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-11T05:13:41.600686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:41.187674Z","time spent":"413.000671ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-11T05:13:41.600698Z","caller":"traceutil/trace.go:171","msg":"trace[1414420573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1569; }","duration":"406.924027ms","start":"2026-03-11T05:13:41.19376Z","end":"2026-03-11T05:13:41.600684Z","steps":["trace[1414420573] 'agreement among raft nodes before linearized reading'  (duration: 406.779033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:41.600748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:41.193729Z","time spent":"407.002458ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-11T05:13:41.600625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.849496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-11T05:13:41.600754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.521395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-faec255e-e3dc-4613-a471-0ff36749dc84\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-03-11T05:13:41.600851Z","caller":"traceutil/trace.go:171","msg":"trace[606970042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1569; }","duration":"412.145533ms","start":"2026-03-11T05:13:41.188673Z","end":"2026-03-11T05:13:41.600818Z","steps":["trace[606970042] 'agreement among raft nodes before linearized reading'  (duration: 411.655632ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:41.6009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.405708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-faec255e-e3dc-4613-a471-0ff36749dc84\" ","response":"range_response_count:1 size:3627"}
{"level":"warn","ts":"2026-03-11T05:13:41.600935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:41.188643Z","time spent":"412.272937ms","remote":"127.0.0.1:48400","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-11T05:13:41.600971Z","caller":"traceutil/trace.go:171","msg":"trace[1637529801] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-faec255e-e3dc-4613-a471-0ff36749dc84; range_end:; response_count:1; response_revision:1569; }","duration":"263.960032ms","start":"2026-03-11T05:13:41.336997Z","end":"2026-03-11T05:13:41.600957Z","steps":["trace[1637529801] 'agreement among raft nodes before linearized reading'  (duration: 263.325827ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:41.60089Z","caller":"traceutil/trace.go:171","msg":"trace[468726761] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-faec255e-e3dc-4613-a471-0ff36749dc84; range_end:; response_count:1; response_revision:1569; }","duration":"329.795663ms","start":"2026-03-11T05:13:41.271073Z","end":"2026-03-11T05:13:41.600869Z","steps":["trace[468726761] 'agreement among raft nodes before linearized reading'  (duration: 329.379602ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:41.601048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:41.271025Z","time spent":"330.013107ms","remote":"127.0.0.1:48336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-faec255e-e3dc-4613-a471-0ff36749dc84\" "}
{"level":"warn","ts":"2026-03-11T05:13:41.601199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.025085ms","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-11T05:13:41.601271Z","caller":"traceutil/trace.go:171","msg":"trace[1941895370] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1569; }","duration":"129.140967ms","start":"2026-03-11T05:13:41.472114Z","end":"2026-03-11T05:13:41.601255Z","steps":["trace[1941895370] 'agreement among raft nodes before linearized reading'  (duration: 128.901862ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:41.735549Z","caller":"traceutil/trace.go:171","msg":"trace[1258343807] transaction","detail":"{read_only:false; response_revision:1571; number_of_response:1; }","duration":"128.684877ms","start":"2026-03-11T05:13:41.606826Z","end":"2026-03-11T05:13:41.735511Z","steps":["trace[1258343807] 'process raft request'  (duration: 128.473721ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:41.735628Z","caller":"traceutil/trace.go:171","msg":"trace[2020077329] transaction","detail":"{read_only:false; response_revision:1572; number_of_response:1; }","duration":"128.652437ms","start":"2026-03-11T05:13:41.606949Z","end":"2026-03-11T05:13:41.735601Z","steps":["trace[2020077329] 'process raft request'  (duration: 128.508304ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:41.735863Z","caller":"traceutil/trace.go:171","msg":"trace[812852156] transaction","detail":"{read_only:false; response_revision:1573; number_of_response:1; }","duration":"126.321994ms","start":"2026-03-11T05:13:41.609508Z","end":"2026-03-11T05:13:41.73583Z","steps":["trace[812852156] 'process raft request'  (duration: 126.027457ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:42.085198Z","caller":"traceutil/trace.go:171","msg":"trace[1532601155] linearizableReadLoop","detail":"{readStateIndex:1635; appliedIndex:1634; }","duration":"257.691761ms","start":"2026-03-11T05:13:41.827473Z","end":"2026-03-11T05:13:42.085165Z","steps":["trace[1532601155] 'read index received'  (duration: 254.718695ms)","trace[1532601155] 'applied index is now lower than readState.Index'  (duration: 2.971056ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:13:42.085234Z","caller":"traceutil/trace.go:171","msg":"trace[436335417] transaction","detail":"{read_only:false; response_revision:1574; number_of_response:1; }","duration":"334.963837ms","start":"2026-03-11T05:13:41.750238Z","end":"2026-03-11T05:13:42.085202Z","steps":["trace[436335417] 'process raft request'  (duration: 332.045882ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:42.085435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.927016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:13:42.085578Z","caller":"traceutil/trace.go:171","msg":"trace[701971781] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1574; }","duration":"258.1118ms","start":"2026-03-11T05:13:41.827437Z","end":"2026-03-11T05:13:42.085549Z","steps":["trace[701971781] 'agreement among raft nodes before linearized reading'  (duration: 257.876754ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:42.085766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:41.750212Z","time spent":"335.364407ms","remote":"127.0.0.1:48336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1513 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10913 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"info","ts":"2026-03-11T05:13:54.026628Z","caller":"traceutil/trace.go:171","msg":"trace[73559782] linearizableReadLoop","detail":"{readStateIndex:1731; appliedIndex:1730; }","duration":"331.537771ms","start":"2026-03-11T05:13:53.695057Z","end":"2026-03-11T05:13:54.026595Z","steps":["trace[73559782] 'read index received'  (duration: 331.282495ms)","trace[73559782] 'applied index is now lower than readState.Index'  (duration: 253.595µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:13:54.026831Z","caller":"traceutil/trace.go:171","msg":"trace[738551947] transaction","detail":"{read_only:false; response_revision:1668; number_of_response:1; }","duration":"369.395677ms","start":"2026-03-11T05:13:53.657416Z","end":"2026-03-11T05:13:54.026812Z","steps":["trace[738551947] 'process raft request'  (duration: 368.947617ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:54.027058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:53.65736Z","time spent":"369.514071ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1657 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-11T05:13:54.027178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.324484ms","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-11T05:13:54.027355Z","caller":"traceutil/trace.go:171","msg":"trace[375504760] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1668; }","duration":"326.467167ms","start":"2026-03-11T05:13:53.700792Z","end":"2026-03-11T05:13:54.027259Z","steps":["trace[375504760] 'agreement among raft nodes before linearized reading'  (duration: 326.218612ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:54.027423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:53.700781Z","time spent":"326.62831ms","remote":"127.0.0.1:56338","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-11T05:13:54.027505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.744718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-11T05:13:54.02755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.362855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:13:54.027588Z","caller":"traceutil/trace.go:171","msg":"trace[1462208608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1668; }","duration":"226.876891ms","start":"2026-03-11T05:13:53.800692Z","end":"2026-03-11T05:13:54.027569Z","steps":["trace[1462208608] 'agreement among raft nodes before linearized reading'  (duration: 226.624325ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:54.027596Z","caller":"traceutil/trace.go:171","msg":"trace[1441897252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1668; }","duration":"326.424256ms","start":"2026-03-11T05:13:53.701158Z","end":"2026-03-11T05:13:54.027582Z","steps":["trace[1441897252] 'agreement among raft nodes before linearized reading'  (duration: 326.348075ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:54.027657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:53.701152Z","time spent":"326.474757ms","remote":"127.0.0.1:48146","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-11T05:13:54.027702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.408036ms","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-11T05:13:54.027675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.069346ms","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-11T05:13:54.027739Z","caller":"traceutil/trace.go:171","msg":"trace[1650645686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1668; }","duration":"207.513868ms","start":"2026-03-11T05:13:53.820214Z","end":"2026-03-11T05:13:54.027727Z","steps":["trace[1650645686] 'agreement among raft nodes before linearized reading'  (duration: 207.405316ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:54.027724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.611424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T05:13:54.027785Z","caller":"traceutil/trace.go:171","msg":"trace[1256226358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1668; }","duration":"270.19483ms","start":"2026-03-11T05:13:53.757559Z","end":"2026-03-11T05:13:54.027754Z","steps":["trace[1256226358] 'agreement among raft nodes before linearized reading'  (duration: 269.820981ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:13:54.027909Z","caller":"traceutil/trace.go:171","msg":"trace[224418597] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1668; }","duration":"332.82524ms","start":"2026-03-11T05:13:53.695004Z","end":"2026-03-11T05:13:54.027829Z","steps":["trace[224418597] 'agreement among raft nodes before linearized reading'  (duration: 332.550063ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:13:54.027983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:13:53.694976Z","time spent":"332.984844ms","remote":"127.0.0.1:49696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "}
{"level":"info","ts":"2026-03-11T05:14:20.361879Z","caller":"traceutil/trace.go:171","msg":"trace[1954835224] linearizableReadLoop","detail":"{readStateIndex:1884; appliedIndex:1883; }","duration":"184.993115ms","start":"2026-03-11T05:14:20.176853Z","end":"2026-03-11T05:14:20.361847Z","steps":["trace[1954835224] 'read index received'  (duration: 184.732929ms)","trace[1954835224] 'applied index is now lower than readState.Index'  (duration: 259.026µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:14:20.361974Z","caller":"traceutil/trace.go:171","msg":"trace[331878870] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"199.833127ms","start":"2026-03-11T05:14:20.162088Z","end":"2026-03-11T05:14:20.361921Z","steps":["trace[331878870] 'process raft request'  (duration: 199.583711ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:20.362251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.356884ms","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-11T05:14:20.362357Z","caller":"traceutil/trace.go:171","msg":"trace[374082335] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1815; }","duration":"185.517477ms","start":"2026-03-11T05:14:20.176818Z","end":"2026-03-11T05:14:20.362336Z","steps":["trace[374082335] 'agreement among raft nodes before linearized reading'  (duration: 185.19374ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:20.362541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.606916ms","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-11T05:14:20.362648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.973565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-11T05:14:20.362706Z","caller":"traceutil/trace.go:171","msg":"trace[471102718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1815; }","duration":"181.075398ms","start":"2026-03-11T05:14:20.181611Z","end":"2026-03-11T05:14:20.362686Z","steps":["trace[471102718] 'agreement among raft nodes before linearized reading'  (duration: 180.860613ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:14:20.362702Z","caller":"traceutil/trace.go:171","msg":"trace[1386976752] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1815; }","duration":"120.830731ms","start":"2026-03-11T05:14:20.241825Z","end":"2026-03-11T05:14:20.362656Z","steps":["trace[1386976752] 'agreement among raft nodes before linearized reading'  (duration: 120.389041ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:20.362715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.093057ms","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-11T05:14:20.362769Z","caller":"traceutil/trace.go:171","msg":"trace[1709888674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1815; }","duration":"185.242131ms","start":"2026-03-11T05:14:20.177511Z","end":"2026-03-11T05:14:20.362753Z","steps":["trace[1709888674] 'agreement among raft nodes before linearized reading'  (duration: 184.566046ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:14:32.577996Z","caller":"traceutil/trace.go:171","msg":"trace[526990375] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"115.755922ms","start":"2026-03-11T05:14:32.462208Z","end":"2026-03-11T05:14:32.577964Z","steps":["trace[526990375] 'read index received'  (duration: 115.599999ms)","trace[526990375] 'applied index is now lower than readState.Index'  (duration: 154.143µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:14:32.57806Z","caller":"traceutil/trace.go:171","msg":"trace[1169726201] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"117.784577ms","start":"2026-03-11T05:14:32.46021Z","end":"2026-03-11T05:14:32.577994Z","steps":["trace[1169726201] 'process raft request'  (duration: 117.538942ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.578332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.06888ms","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-11T05:14:32.578384Z","caller":"traceutil/trace.go:171","msg":"trace[1551944580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1873; }","duration":"116.168081ms","start":"2026-03-11T05:14:32.462199Z","end":"2026-03-11T05:14:32.578367Z","steps":["trace[1551944580] 'agreement among raft nodes before linearized reading'  (duration: 115.966937ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.578441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.183942ms","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-11T05:14:32.57849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.122329ms","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-11T05:14:32.578563Z","caller":"traceutil/trace.go:171","msg":"trace[645352910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1873; }","duration":"116.387327ms","start":"2026-03-11T05:14:32.462144Z","end":"2026-03-11T05:14:32.578531Z","steps":["trace[645352910] 'agreement among raft nodes before linearized reading'  (duration: 115.989418ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.578642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.038144ms","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-11T05:14:32.578645Z","caller":"traceutil/trace.go:171","msg":"trace[426517274] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1873; }","duration":"111.275903ms","start":"2026-03-11T05:14:32.46729Z","end":"2026-03-11T05:14:32.578566Z","steps":["trace[426517274] 'agreement among raft nodes before linearized reading'  (duration: 110.955035ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:14:32.578686Z","caller":"traceutil/trace.go:171","msg":"trace[1253996114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1873; }","duration":"114.119476ms","start":"2026-03-11T05:14:32.464555Z","end":"2026-03-11T05:14:32.578675Z","steps":["trace[1253996114] 'agreement among raft nodes before linearized reading'  (duration: 113.910051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.872888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.532252ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541202281435924 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1866 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T05:14:32.87299Z","caller":"traceutil/trace.go:171","msg":"trace[631991904] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"288.976545ms","start":"2026-03-11T05:14:32.583997Z","end":"2026-03-11T05:14:32.872973Z","steps":["trace[631991904] 'process raft request'  (duration: 171.256009ms)","trace[631991904] 'compare'  (duration: 117.273356ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:14:32.891893Z","caller":"traceutil/trace.go:171","msg":"trace[401381662] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1945; }","duration":"188.291909ms","start":"2026-03-11T05:14:32.703575Z","end":"2026-03-11T05:14:32.891866Z","steps":["trace[401381662] 'read index received'  (duration: 51.697053ms)","trace[401381662] 'applied index is now lower than readState.Index'  (duration: 136.593436ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:14:32.891918Z","caller":"traceutil/trace.go:171","msg":"trace[277676157] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"307.689493ms","start":"2026-03-11T05:14:32.584199Z","end":"2026-03-11T05:14:32.891889Z","steps":["trace[277676157] 'process raft request'  (duration: 307.427087ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.892033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:14:32.584168Z","time spent":"307.814916ms","remote":"127.0.0.1:48400","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:1868 > 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-11T05:14:32.891976Z","caller":"traceutil/trace.go:171","msg":"trace[427309005] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"307.09484ms","start":"2026-03-11T05:14:32.584847Z","end":"2026-03-11T05:14:32.891941Z","steps":["trace[427309005] 'process raft request'  (duration: 306.935177ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:14:32.892224Z","caller":"traceutil/trace.go:171","msg":"trace[2094145076] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"200.500132ms","start":"2026-03-11T05:14:32.691707Z","end":"2026-03-11T05:14:32.892207Z","steps":["trace[2094145076] 'process raft request'  (duration: 200.115603ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.892247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.647947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:14:32.892436Z","caller":"traceutil/trace.go:171","msg":"trace[1671575624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1877; }","duration":"188.78382ms","start":"2026-03-11T05:14:32.703508Z","end":"2026-03-11T05:14:32.892292Z","steps":["trace[1671575624] 'agreement among raft nodes before linearized reading'  (duration: 188.466693ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:14:32.892579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:14:32.584821Z","time spent":"307.273843ms","remote":"127.0.0.1:48400","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:1867 > 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-11T05:14:32.893247Z","caller":"traceutil/trace.go:171","msg":"trace[919732317] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"126.530502ms","start":"2026-03-11T05:14:32.766678Z","end":"2026-03-11T05:14:32.893208Z","steps":["trace[919732317] 'process raft request'  (duration: 126.372898ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:16:01.630007Z","caller":"traceutil/trace.go:171","msg":"trace[838308204] transaction","detail":"{read_only:false; response_revision:2505; number_of_response:1; }","duration":"260.552109ms","start":"2026-03-11T05:16:01.366756Z","end":"2026-03-11T05:16:01.627308Z","steps":["trace[838308204] 'process raft request'  (duration: 219.653708ms)","trace[838308204] 'compare'  (duration: 40.108683ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:16:01.63013Z","caller":"traceutil/trace.go:171","msg":"trace[1053313746] linearizableReadLoop","detail":"{readStateIndex:2603; appliedIndex:2601; }","duration":"253.602113ms","start":"2026-03-11T05:16:01.376419Z","end":"2026-03-11T05:16:01.630021Z","steps":["trace[1053313746] 'read index received'  (duration: 210.084034ms)","trace[1053313746] 'applied index is now lower than readState.Index'  (duration: 43.483948ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:16:01.630402Z","caller":"traceutil/trace.go:171","msg":"trace[493824513] transaction","detail":"{read_only:false; response_revision:2506; number_of_response:1; }","duration":"262.931242ms","start":"2026-03-11T05:16:01.367437Z","end":"2026-03-11T05:16:01.630368Z","steps":["trace[493824513] 'process raft request'  (duration: 259.775481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:16:01.631013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.569815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:16:01.631088Z","caller":"traceutil/trace.go:171","msg":"trace[1492599388] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2506; }","duration":"254.689928ms","start":"2026-03-11T05:16:01.376382Z","end":"2026-03-11T05:16:01.631072Z","steps":["trace[1492599388] 'agreement among raft nodes before linearized reading'  (duration: 254.356591ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:16:01.631102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.154159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T05:16:01.631244Z","caller":"traceutil/trace.go:171","msg":"trace[1562463096] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2506; }","duration":"212.404925ms","start":"2026-03-11T05:16:01.418811Z","end":"2026-03-11T05:16:01.631216Z","steps":["trace[1562463096] 'agreement among raft nodes before linearized reading'  (duration: 211.846643ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:16:01.631423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.847887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-03-11T05:16:01.631699Z","caller":"traceutil/trace.go:171","msg":"trace[373549410] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2506; }","duration":"166.177215ms","start":"2026-03-11T05:16:01.465506Z","end":"2026-03-11T05:16:01.631683Z","steps":["trace[373549410] 'agreement among raft nodes before linearized reading'  (duration: 165.771116ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:16:01.801092Z","caller":"traceutil/trace.go:171","msg":"trace[1848867585] linearizableReadLoop","detail":"{readStateIndex:2604; appliedIndex:2603; }","duration":"162.122793ms","start":"2026-03-11T05:16:01.638928Z","end":"2026-03-11T05:16:01.801051Z","steps":["trace[1848867585] 'read index received'  (duration: 152.0668ms)","trace[1848867585] 'applied index is now lower than readState.Index'  (duration: 10.054693ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:16:01.801117Z","caller":"traceutil/trace.go:171","msg":"trace[534219400] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"164.408994ms","start":"2026-03-11T05:16:01.636665Z","end":"2026-03-11T05:16:01.801074Z","steps":["trace[534219400] 'process raft request'  (duration: 154.32613ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:16:01.801368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.405381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"}
{"level":"info","ts":"2026-03-11T05:16:01.801449Z","caller":"traceutil/trace.go:171","msg":"trace[1232308304] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2507; }","duration":"162.514743ms","start":"2026-03-11T05:16:01.638912Z","end":"2026-03-11T05:16:01.801427Z","steps":["trace[1232308304] 'agreement among raft nodes before linearized reading'  (duration: 162.257077ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:18:38.073114Z","caller":"traceutil/trace.go:171","msg":"trace[2121246112] transaction","detail":"{read_only:false; response_revision:3448; number_of_response:1; }","duration":"253.945137ms","start":"2026-03-11T05:18:37.81913Z","end":"2026-03-11T05:18:38.073075Z","steps":["trace[2121246112] 'process raft request'  (duration: 203.654415ms)","trace[2121246112] 'compare'  (duration: 49.978404ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:18:38.07315Z","caller":"traceutil/trace.go:171","msg":"trace[1597544334] transaction","detail":"{read_only:false; response_revision:3449; number_of_response:1; }","duration":"252.976285ms","start":"2026-03-11T05:18:37.820141Z","end":"2026-03-11T05:18:38.073117Z","steps":["trace[1597544334] 'process raft request'  (duration: 252.849852ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:18:38.073098Z","caller":"traceutil/trace.go:171","msg":"trace[143232320] linearizableReadLoop","detail":"{readStateIndex:3585; appliedIndex:3583; }","duration":"226.387951ms","start":"2026-03-11T05:18:37.846674Z","end":"2026-03-11T05:18:38.073062Z","steps":["trace[143232320] 'read index received'  (duration: 176.025137ms)","trace[143232320] 'applied index is now lower than readState.Index'  (duration: 50.361014ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:18:38.073402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.698967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-11T05:18:38.073467Z","caller":"traceutil/trace.go:171","msg":"trace[809809595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3449; }","duration":"226.835431ms","start":"2026-03-11T05:18:37.84662Z","end":"2026-03-11T05:18:38.073455Z","steps":["trace[809809595] 'agreement among raft nodes before linearized reading'  (duration: 226.564794ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:18:38.073535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.866544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-03-11T05:18:38.073608Z","caller":"traceutil/trace.go:171","msg":"trace[1845074449] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3449; }","duration":"114.995867ms","start":"2026-03-11T05:18:37.958594Z","end":"2026-03-11T05:18:38.07359Z","steps":["trace[1845074449] 'agreement among raft nodes before linearized reading'  (duration: 114.777302ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:01.777925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.059334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-03-11T05:20:01.778095Z","caller":"traceutil/trace.go:171","msg":"trace[1209986997] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4455; }","duration":"127.25271ms","start":"2026-03-11T05:20:01.650815Z","end":"2026-03-11T05:20:01.778067Z","steps":["trace[1209986997] 'range keys from in-memory index tree'  (duration: 126.8675ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.827992Z","caller":"traceutil/trace.go:171","msg":"trace[953750680] transaction","detail":"{read_only:false; response_revision:4518; number_of_response:1; }","duration":"197.492547ms","start":"2026-03-11T05:20:02.630479Z","end":"2026-03-11T05:20:02.827972Z","steps":["trace[953750680] 'process raft request'  (duration: 197.005437ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.835485Z","caller":"traceutil/trace.go:171","msg":"trace[2025067210] transaction","detail":"{read_only:false; response_revision:4519; number_of_response:1; }","duration":"202.884299ms","start":"2026-03-11T05:20:02.632561Z","end":"2026-03-11T05:20:02.835445Z","steps":["trace[2025067210] 'process raft request'  (duration: 202.621423ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.835543Z","caller":"traceutil/trace.go:171","msg":"trace[658809474] transaction","detail":"{read_only:false; response_revision:4520; number_of_response:1; }","duration":"202.921619ms","start":"2026-03-11T05:20:02.632596Z","end":"2026-03-11T05:20:02.835518Z","steps":["trace[658809474] 'process raft request'  (duration: 202.771846ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.835722Z","caller":"traceutil/trace.go:171","msg":"trace[529999257] transaction","detail":"{read_only:false; response_revision:4521; number_of_response:1; }","duration":"203.048252ms","start":"2026-03-11T05:20:02.632643Z","end":"2026-03-11T05:20:02.835692Z","steps":["trace[529999257] 'process raft request'  (duration: 202.800247ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.836087Z","caller":"traceutil/trace.go:171","msg":"trace[417232136] transaction","detail":"{read_only:false; response_revision:4522; number_of_response:1; }","duration":"203.35708ms","start":"2026-03-11T05:20:02.632715Z","end":"2026-03-11T05:20:02.836072Z","steps":["trace[417232136] 'process raft request'  (duration: 202.773077ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.836128Z","caller":"traceutil/trace.go:171","msg":"trace[832101100] transaction","detail":"{read_only:false; response_revision:4523; number_of_response:1; }","duration":"203.329048ms","start":"2026-03-11T05:20:02.632786Z","end":"2026-03-11T05:20:02.836115Z","steps":["trace[832101100] 'process raft request'  (duration: 202.763916ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.83613Z","caller":"traceutil/trace.go:171","msg":"trace[1142830238] linearizableReadLoop","detail":"{readStateIndex:4697; appliedIndex:4692; }","duration":"203.362419ms","start":"2026-03-11T05:20:02.632743Z","end":"2026-03-11T05:20:02.836106Z","steps":["trace[1142830238] 'read index received'  (duration: 194.859048ms)","trace[1142830238] 'applied index is now lower than readState.Index'  (duration: 8.502221ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:20:02.836239Z","caller":"traceutil/trace.go:171","msg":"trace[1555538736] transaction","detail":"{read_only:false; response_revision:4525; number_of_response:1; }","duration":"201.662922ms","start":"2026-03-11T05:20:02.634563Z","end":"2026-03-11T05:20:02.836226Z","steps":["trace[1555538736] 'process raft request'  (duration: 201.088679ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.836443Z","caller":"traceutil/trace.go:171","msg":"trace[1012854627] transaction","detail":"{read_only:false; response_revision:4526; number_of_response:1; }","duration":"201.682733ms","start":"2026-03-11T05:20:02.634749Z","end":"2026-03-11T05:20:02.836432Z","steps":["trace[1012854627] 'process raft request'  (duration: 200.985727ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.836469Z","caller":"traceutil/trace.go:171","msg":"trace[1035921015] transaction","detail":"{read_only:false; response_revision:4527; number_of_response:1; }","duration":"150.664935ms","start":"2026-03-11T05:20:02.685789Z","end":"2026-03-11T05:20:02.836454Z","steps":["trace[1035921015] 'process raft request'  (duration: 150.112653ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:02.836153Z","caller":"traceutil/trace.go:171","msg":"trace[1878274842] transaction","detail":"{read_only:false; response_revision:4524; number_of_response:1; }","duration":"202.548331ms","start":"2026-03-11T05:20:02.633591Z","end":"2026-03-11T05:20:02.836139Z","steps":["trace[1878274842] 'process raft request'  (duration: 202.002689ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:02.836655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.899841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/loki-gateway\" ","response":"range_response_count:1 size:4305"}
{"level":"info","ts":"2026-03-11T05:20:02.836709Z","caller":"traceutil/trace.go:171","msg":"trace[1598239817] range","detail":"{range_begin:/registry/deployments/monitoring/loki-gateway; range_end:; response_count:1; response_revision:4527; }","duration":"203.996553ms","start":"2026-03-11T05:20:02.632699Z","end":"2026-03-11T05:20:02.836696Z","steps":["trace[1598239817] 'agreement among raft nodes before linearized reading'  (duration: 203.805649ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:02.837678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.954691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-11T05:20:02.837736Z","caller":"traceutil/trace.go:171","msg":"trace[71712065] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4528; }","duration":"191.032832ms","start":"2026-03-11T05:20:02.646692Z","end":"2026-03-11T05:20:02.837725Z","steps":["trace[71712065] 'agreement among raft nodes before linearized reading'  (duration: 190.602793ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:02.838134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.601208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4bfkm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T05:20:02.838176Z","caller":"traceutil/trace.go:171","msg":"trace[1877357382] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4bfkm; range_end:; response_count:1; response_revision:4528; }","duration":"111.653639ms","start":"2026-03-11T05:20:02.726512Z","end":"2026-03-11T05:20:02.838166Z","steps":["trace[1877357382] 'agreement among raft nodes before linearized reading'  (duration: 111.507606ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:02.838384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.650421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:20:02.838413Z","caller":"traceutil/trace.go:171","msg":"trace[113113243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4528; }","duration":"136.699532ms","start":"2026-03-11T05:20:02.701704Z","end":"2026-03-11T05:20:02.838404Z","steps":["trace[113113243] 'agreement among raft nodes before linearized reading'  (duration: 136.620411ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:02.838615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.160141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-11T05:20:02.838653Z","caller":"traceutil/trace.go:171","msg":"trace[471730674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4528; }","duration":"185.216982ms","start":"2026-03-11T05:20:02.653427Z","end":"2026-03-11T05:20:02.838644Z","steps":["trace[471730674] 'agreement among raft nodes before linearized reading'  (duration: 185.117889ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:04.532415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.519128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-005119a6-788c-47b8-8ba0-79eefacb058e\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-03-11T05:20:04.532459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.050813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9nrhn.189bb1d3ff305cd6\" ","response":"range_response_count:1 size:962"}
{"level":"info","ts":"2026-03-11T05:20:04.532527Z","caller":"traceutil/trace.go:171","msg":"trace[71673377] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-005119a6-788c-47b8-8ba0-79eefacb058e; range_end:; response_count:1; response_revision:4582; }","duration":"120.691693ms","start":"2026-03-11T05:20:04.411807Z","end":"2026-03-11T05:20:04.532499Z","steps":["trace[71673377] 'range keys from in-memory index tree'  (duration: 120.296403ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:04.532509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.965188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:20:04.532562Z","caller":"traceutil/trace.go:171","msg":"trace[2024229693] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9nrhn.189bb1d3ff305cd6; range_end:; response_count:1; response_revision:4582; }","duration":"114.215307ms","start":"2026-03-11T05:20:04.418318Z","end":"2026-03-11T05:20:04.532534Z","steps":["trace[2024229693] 'range keys from in-memory index tree'  (duration: 113.860289ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:04.532618Z","caller":"traceutil/trace.go:171","msg":"trace[798414439] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4582; }","duration":"149.146102ms","start":"2026-03-11T05:20:04.383446Z","end":"2026-03-11T05:20:04.532592Z","steps":["trace[798414439] 'count revisions from in-memory index tree'  (duration: 148.796653ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:24.404024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.978109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:20:24.404287Z","caller":"traceutil/trace.go:171","msg":"trace[1307796273] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:4976; }","duration":"121.317366ms","start":"2026-03-11T05:20:24.282942Z","end":"2026-03-11T05:20:24.404259Z","steps":["trace[1307796273] 'count revisions from in-memory index tree'  (duration: 120.789644ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:24.648662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.513868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"}
{"level":"info","ts":"2026-03-11T05:20:24.648743Z","caller":"traceutil/trace.go:171","msg":"trace[1044737678] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4977; }","duration":"144.660071ms","start":"2026-03-11T05:20:24.504065Z","end":"2026-03-11T05:20:24.648725Z","steps":["trace[1044737678] 'range keys from in-memory index tree'  (duration: 144.405986ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.023164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.112861ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1673541202281443381 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4879 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T05:20:25.023298Z","caller":"traceutil/trace.go:171","msg":"trace[735698645] linearizableReadLoop","detail":"{readStateIndex:5166; appliedIndex:5164; }","duration":"383.17813ms","start":"2026-03-11T05:20:24.640096Z","end":"2026-03-11T05:20:25.023274Z","steps":["trace[735698645] 'read index received'  (duration: 48.869068ms)","trace[735698645] 'applied index is now lower than readState.Index'  (duration: 334.307012ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:20:25.02343Z","caller":"traceutil/trace.go:171","msg":"trace[93222584] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"393.506762ms","start":"2026-03-11T05:20:24.629904Z","end":"2026-03-11T05:20:25.02341Z","steps":["trace[93222584] 'process raft request'  (duration: 220.039553ms)","trace[93222584] 'compare'  (duration: 172.929547ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:20:25.023533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:20:24.62986Z","time spent":"393.619024ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4879 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-11T05:20:25.023674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.918926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-11T05:20:25.02382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.022748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-11T05:20:25.02383Z","caller":"traceutil/trace.go:171","msg":"trace[906021302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4979; }","duration":"323.091971ms","start":"2026-03-11T05:20:24.700682Z","end":"2026-03-11T05:20:25.023774Z","steps":["trace[906021302] 'agreement among raft nodes before linearized reading'  (duration: 322.881125ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:25.02387Z","caller":"traceutil/trace.go:171","msg":"trace[1928208607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4979; }","duration":"363.083029ms","start":"2026-03-11T05:20:24.66077Z","end":"2026-03-11T05:20:25.023853Z","steps":["trace[1928208607] 'agreement among raft nodes before linearized reading'  (duration: 362.991427ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.023844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.716522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d28d1066-7ea1-4ffd-b233-e01cce4644f4\" ","response":"range_response_count:1 size:3646"}
{"level":"warn","ts":"2026-03-11T05:20:25.023914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:20:24.660759Z","time spent":"363.149141ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-11T05:20:25.02395Z","caller":"traceutil/trace.go:171","msg":"trace[1228557096] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d28d1066-7ea1-4ffd-b233-e01cce4644f4; range_end:; response_count:1; response_revision:4979; }","duration":"383.904217ms","start":"2026-03-11T05:20:24.640023Z","end":"2026-03-11T05:20:25.023927Z","steps":["trace[1228557096] 'agreement among raft nodes before linearized reading'  (duration: 383.548978ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.024025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:20:24.64001Z","time spent":"384.006479ms","remote":"127.0.0.1:48336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3670,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d28d1066-7ea1-4ffd-b233-e01cce4644f4\" "}
{"level":"warn","ts":"2026-03-11T05:20:25.023959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:20:24.700657Z","time spent":"323.252935ms","remote":"127.0.0.1:48146","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-11T05:20:25.023717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.234961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"}
{"level":"info","ts":"2026-03-11T05:20:25.024205Z","caller":"traceutil/trace.go:171","msg":"trace[1434831464] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4979; }","duration":"370.804553ms","start":"2026-03-11T05:20:24.653389Z","end":"2026-03-11T05:20:25.024193Z","steps":["trace[1434831464] 'agreement among raft nodes before linearized reading'  (duration: 370.133957ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.024232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:20:24.653358Z","time spent":"370.867185ms","remote":"127.0.0.1:48234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":720,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" "}
{"level":"info","ts":"2026-03-11T05:20:25.301802Z","caller":"traceutil/trace.go:171","msg":"trace[557349442] linearizableReadLoop","detail":"{readStateIndex:5169; appliedIndex:5167; }","duration":"198.559642ms","start":"2026-03-11T05:20:25.103216Z","end":"2026-03-11T05:20:25.301775Z","steps":["trace[557349442] 'read index received'  (duration: 198.290887ms)","trace[557349442] 'applied index is now lower than readState.Index'  (duration: 267.365µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:20:25.301942Z","caller":"traceutil/trace.go:171","msg":"trace[1726217207] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"270.044509ms","start":"2026-03-11T05:20:25.031861Z","end":"2026-03-11T05:20:25.301906Z","steps":["trace[1726217207] 'process raft request'  (duration: 269.841065ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:25.301928Z","caller":"traceutil/trace.go:171","msg":"trace[952506902] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"271.582653ms","start":"2026-03-11T05:20:25.030302Z","end":"2026-03-11T05:20:25.301885Z","steps":["trace[952506902] 'process raft request'  (duration: 271.219815ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.302297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.192796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80222"}
{"level":"info","ts":"2026-03-11T05:20:25.30237Z","caller":"traceutil/trace.go:171","msg":"trace[1650787956] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:4982; }","duration":"272.278188ms","start":"2026-03-11T05:20:25.030076Z","end":"2026-03-11T05:20:25.302354Z","steps":["trace[1650787956] 'agreement among raft nodes before linearized reading'  (duration: 271.88939ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.303907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.051172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.195\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-11T05:20:25.303979Z","caller":"traceutil/trace.go:171","msg":"trace[1907453064] range","detail":"{range_begin:/registry/masterleases/162.253.55.195; range_end:; response_count:1; response_revision:4984; }","duration":"126.138755ms","start":"2026-03-11T05:20:25.17783Z","end":"2026-03-11T05:20:25.303968Z","steps":["trace[1907453064] 'agreement among raft nodes before linearized reading'  (duration: 125.983992ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.304057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.695796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"}
{"level":"warn","ts":"2026-03-11T05:20:25.304114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.652595ms","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-11T05:20:25.304138Z","caller":"traceutil/trace.go:171","msg":"trace[773867227] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4984; }","duration":"194.825988ms","start":"2026-03-11T05:20:25.109293Z","end":"2026-03-11T05:20:25.304119Z","steps":["trace[773867227] 'agreement among raft nodes before linearized reading'  (duration: 194.48911ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:20:25.304169Z","caller":"traceutil/trace.go:171","msg":"trace[1159714999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4984; }","duration":"170.742087ms","start":"2026-03-11T05:20:25.133407Z","end":"2026-03-11T05:20:25.304149Z","steps":["trace[1159714999] 'agreement among raft nodes before linearized reading'  (duration: 170.585794ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.304177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.283472ms","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-11T05:20:25.304244Z","caller":"traceutil/trace.go:171","msg":"trace[692965293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4984; }","duration":"172.374584ms","start":"2026-03-11T05:20:25.131852Z","end":"2026-03-11T05:20:25.304226Z","steps":["trace[692965293] 'agreement among raft nodes before linearized reading'  (duration: 172.18781ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:20:25.304562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.938902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-03-11T05:20:25.304584Z","caller":"traceutil/trace.go:171","msg":"trace[2116861068] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4984; }","duration":"154.978063ms","start":"2026-03-11T05:20:25.149597Z","end":"2026-03-11T05:20:25.304575Z","steps":["trace[2116861068] 'agreement among raft nodes before linearized reading'  (duration: 154.730558ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:21:52.056456Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2755}
{"level":"info","ts":"2026-03-11T05:21:52.122591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2755,"took":"64.119973ms","hash":1182804111,"current-db-size-bytes":41381888,"current-db-size":"41 MB","current-db-size-in-use-bytes":30715904,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-11T05:21:52.122672Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1182804111,"revision":2755,"compact-revision":-1}
{"level":"info","ts":"2026-03-11T05:26:33.317957Z","caller":"traceutil/trace.go:171","msg":"trace[1287838972] transaction","detail":"{read_only:false; response_revision:7636; number_of_response:1; }","duration":"145.822561ms","start":"2026-03-11T05:26:33.172089Z","end":"2026-03-11T05:26:33.317911Z","steps":["trace[1287838972] 'process raft request'  (duration: 145.619847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:26:33.516413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.648271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-11T05:26:33.516506Z","caller":"traceutil/trace.go:171","msg":"trace[18746756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7636; }","duration":"100.806745ms","start":"2026-03-11T05:26:33.415678Z","end":"2026-03-11T05:26:33.516484Z","steps":["trace[18746756] 'range keys from in-memory index tree'  (duration: 100.465897ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:26:44.531542Z","caller":"traceutil/trace.go:171","msg":"trace[455020945] linearizableReadLoop","detail":"{readStateIndex:7967; appliedIndex:7966; }","duration":"238.172857ms","start":"2026-03-11T05:26:44.293341Z","end":"2026-03-11T05:26:44.531513Z","steps":["trace[455020945] 'read index received'  (duration: 232.570941ms)","trace[455020945] 'applied index is now lower than readState.Index'  (duration: 5.600746ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:26:44.531765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.395733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:26:44.531797Z","caller":"traceutil/trace.go:171","msg":"trace[1555031248] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:7689; }","duration":"238.519215ms","start":"2026-03-11T05:26:44.293269Z","end":"2026-03-11T05:26:44.531789Z","steps":["trace[1555031248] 'agreement among raft nodes before linearized reading'  (duration: 238.346201ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:26:44.532116Z","caller":"traceutil/trace.go:171","msg":"trace[1653276268] transaction","detail":"{read_only:false; response_revision:7689; number_of_response:1; }","duration":"325.851698ms","start":"2026-03-11T05:26:44.206255Z","end":"2026-03-11T05:26:44.532107Z","steps":["trace[1653276268] 'process raft request'  (duration: 319.69237ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:26:44.5322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:26:44.206221Z","time spent":"325.92092ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:7678 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-03-11T05:26:45.590097Z","caller":"traceutil/trace.go:171","msg":"trace[881756240] linearizableReadLoop","detail":"{readStateIndex:7970; appliedIndex:7969; }","duration":"353.273022ms","start":"2026-03-11T05:26:45.236804Z","end":"2026-03-11T05:26:45.590077Z","steps":["trace[881756240] 'read index received'  (duration: 353.126399ms)","trace[881756240] 'applied index is now lower than readState.Index'  (duration: 145.243µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:26:45.590123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:26:45.200175Z","time spent":"389.931743ms","remote":"127.0.0.1:48166","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-11T05:26:45.590299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.465457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:26:45.590401Z","caller":"traceutil/trace.go:171","msg":"trace[1691522264] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:7691; }","duration":"353.637851ms","start":"2026-03-11T05:26:45.23674Z","end":"2026-03-11T05:26:45.590378Z","steps":["trace[1691522264] 'agreement among raft nodes before linearized reading'  (duration: 353.450337ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:26:45.590464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:26:45.236714Z","time spent":"353.739083ms","remote":"127.0.0.1:48368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-03-11T05:26:45.590412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.28528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-11T05:26:45.590539Z","caller":"traceutil/trace.go:171","msg":"trace[808210904] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7691; }","duration":"183.482404ms","start":"2026-03-11T05:26:45.407041Z","end":"2026-03-11T05:26:45.590523Z","steps":["trace[808210904] 'agreement among raft nodes before linearized reading'  (duration: 183.199128ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:26:46.274077Z","caller":"traceutil/trace.go:171","msg":"trace[2042911318] linearizableReadLoop","detail":"{readStateIndex:7978; appliedIndex:7977; }","duration":"114.511382ms","start":"2026-03-11T05:26:46.159531Z","end":"2026-03-11T05:26:46.274043Z","steps":["trace[2042911318] 'read index received'  (duration: 114.41385ms)","trace[2042911318] 'applied index is now lower than readState.Index'  (duration: 96.072µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:26:46.274265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.707556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T05:26:46.274168Z","caller":"traceutil/trace.go:171","msg":"trace[1073371076] transaction","detail":"{read_only:false; response_revision:7699; number_of_response:1; }","duration":"179.201549ms","start":"2026-03-11T05:26:46.094916Z","end":"2026-03-11T05:26:46.274118Z","steps":["trace[1073371076] 'process raft request'  (duration: 178.908692ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:26:46.27432Z","caller":"traceutil/trace.go:171","msg":"trace[2094893146] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:7699; }","duration":"114.812739ms","start":"2026-03-11T05:26:46.159491Z","end":"2026-03-11T05:26:46.274304Z","steps":["trace[2094893146] 'agreement among raft nodes before linearized reading'  (duration: 114.689756ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:26:46.736597Z","caller":"traceutil/trace.go:171","msg":"trace[1197602801] transaction","detail":"{read_only:false; response_revision:7702; number_of_response:1; }","duration":"114.979732ms","start":"2026-03-11T05:26:46.621579Z","end":"2026-03-11T05:26:46.736559Z","steps":["trace[1197602801] 'process raft request'  (duration: 114.720956ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:26:52.064332Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5712}
{"level":"info","ts":"2026-03-11T05:26:52.157129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5712,"took":"90.31257ms","hash":2368900839,"current-db-size-bytes":43311104,"current-db-size":"43 MB","current-db-size-in-use-bytes":23298048,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-11T05:26:52.157212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2368900839,"revision":5712,"compact-revision":2755}
{"level":"info","ts":"2026-03-11T05:27:14.098413Z","caller":"traceutil/trace.go:171","msg":"trace[527623474] linearizableReadLoop","detail":"{readStateIndex:8171; appliedIndex:8170; }","duration":"267.678317ms","start":"2026-03-11T05:27:13.830699Z","end":"2026-03-11T05:27:14.098378Z","steps":["trace[527623474] 'read index received'  (duration: 267.399641ms)","trace[527623474] 'applied index is now lower than readState.Index'  (duration: 277.266µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T05:27:14.098557Z","caller":"traceutil/trace.go:171","msg":"trace[929473257] transaction","detail":"{read_only:false; response_revision:7884; number_of_response:1; }","duration":"302.622249ms","start":"2026-03-11T05:27:13.795896Z","end":"2026-03-11T05:27:14.098519Z","steps":["trace[929473257] 'process raft request'  (duration: 302.297582ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:27:14.098751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T05:27:13.795879Z","time spent":"302.775342ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:7874 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-11T05:27:14.098814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.086996ms","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-11T05:27:14.098843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.985245ms","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-11T05:27:14.098958Z","caller":"traceutil/trace.go:171","msg":"trace[119553991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7884; }","duration":"264.113167ms","start":"2026-03-11T05:27:13.834828Z","end":"2026-03-11T05:27:14.098941Z","steps":["trace[119553991] 'agreement among raft nodes before linearized reading'  (duration: 263.908443ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:27:14.099115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.596571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-11T05:27:14.098944Z","caller":"traceutil/trace.go:171","msg":"trace[741708535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7884; }","duration":"268.202308ms","start":"2026-03-11T05:27:13.830676Z","end":"2026-03-11T05:27:14.098879Z","steps":["trace[741708535] 'agreement among raft nodes before linearized reading'  (duration: 267.8609ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:27:14.09916Z","caller":"traceutil/trace.go:171","msg":"trace[2075948332] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7884; }","duration":"164.680183ms","start":"2026-03-11T05:27:13.93447Z","end":"2026-03-11T05:27:14.09915Z","steps":["trace[2075948332] 'agreement among raft nodes before linearized reading'  (duration: 164.53716ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:27:14.099295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.733246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T05:27:14.099355Z","caller":"traceutil/trace.go:171","msg":"trace[1427552269] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:7884; }","duration":"245.843168ms","start":"2026-03-11T05:27:13.853494Z","end":"2026-03-11T05:27:14.099337Z","steps":["trace[1427552269] 'agreement among raft nodes before linearized reading'  (duration: 245.718035ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:27:14.099183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.83699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-11T05:27:14.099532Z","caller":"traceutil/trace.go:171","msg":"trace[1512061369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7884; }","duration":"247.205359ms","start":"2026-03-11T05:27:13.852288Z","end":"2026-03-11T05:27:14.099493Z","steps":["trace[1512061369] 'agreement among raft nodes before linearized reading'  (duration: 246.795669ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T05:27:14.099575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.33419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4bfkm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T05:27:14.099637Z","caller":"traceutil/trace.go:171","msg":"trace[876678421] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4bfkm; range_end:; response_count:1; response_revision:7884; }","duration":"119.441222ms","start":"2026-03-11T05:27:13.980182Z","end":"2026-03-11T05:27:14.099623Z","steps":["trace[876678421] 'agreement among raft nodes before linearized reading'  (duration: 119.289488ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:27:14.313176Z","caller":"traceutil/trace.go:171","msg":"trace[969658501] transaction","detail":"{read_only:false; response_revision:7889; number_of_response:1; }","duration":"166.31767ms","start":"2026-03-11T05:27:14.146833Z","end":"2026-03-11T05:27:14.313151Z","steps":["trace[969658501] 'process raft request'  (duration: 130.644702ms)","trace[969658501] 'compare'  (duration: 35.561576ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T05:28:44.9001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.771747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4bfkm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-11T05:28:44.900237Z","caller":"traceutil/trace.go:171","msg":"trace[1067823001] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4bfkm; range_end:; response_count:1; response_revision:8712; }","duration":"119.973591ms","start":"2026-03-11T05:28:44.780236Z","end":"2026-03-11T05:28:44.90021Z","steps":["trace[1067823001] 'range keys from in-memory index tree'  (duration: 119.538032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T05:30:57.392144Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b66d12fd59101739","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-11T05:30:57.397046Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-11T05:30:57.397152Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-11T05:31:52.072232Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7731}
{"level":"info","ts":"2026-03-11T05:31:52.142228Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7731,"took":"66.567162ms","hash":3488477913,"current-db-size-bytes":43311104,"current-db-size":"43 MB","current-db-size-in-use-bytes":26189824,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-11T05:31:52.142302Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3488477913,"revision":7731,"compact-revision":5712}
{"level":"info","ts":"2026-03-11T05:36:52.083316Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9978}
{"level":"info","ts":"2026-03-11T05:36:52.164193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9978,"took":"78.125948ms","hash":2733745320,"current-db-size-bytes":43311104,"current-db-size":"43 MB","current-db-size-in-use-bytes":17154048,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-11T05:36:52.164253Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2733745320,"revision":9978,"compact-revision":7731}