{"level":"warn","ts":"2026-02-22T17:48:57.223056Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-22T17:48:57.223141Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.122:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.122:2380","--initial-cluster=instance=https://199.204.45.122:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.122:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.122:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-22T17:48:57.223206Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-22T17:48:57.223214Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.122:2380"]}
{"level":"info","ts":"2026-02-22T17:48:57.223231Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-22T17:48:57.223839Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"]}
{"level":"info","ts":"2026-02-22T17:48:57.223917Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.122:2380"],"listen-peer-urls":["https://199.204.45.122:2380"],"advertise-client-urls":["https://199.204.45.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.122:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-22T17:48:57.230378Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.123652ms"}
{"level":"info","ts":"2026-02-22T17:48:57.238535Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d2c3f297b56db0c4","cluster-id":"becafec23d27c587"}
{"level":"info","ts":"2026-02-22T17:48:57.238641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-22T17:48:57.238665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 0"}
{"level":"info","ts":"2026-02-22T17:48:57.238678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d2c3f297b56db0c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-22T17:48:57.238685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 1"}
{"level":"info","ts":"2026-02-22T17:48:57.238716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"}
{"level":"warn","ts":"2026-02-22T17:48:57.244437Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-22T17:48:57.245516Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-22T17:48:57.246546Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-22T17:48:57.248201Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d2c3f297b56db0c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-22T17:48:57.248666Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d2c3f297b56db0c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-22T17:48:57.249305Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-22T17:48:57.249395Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-22T17:48:57.24943Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-22T17:48:57.250713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"}
{"level":"info","ts":"2026-02-22T17:48:57.250967Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"becafec23d27c587","local-member-id":"d2c3f297b56db0c4","added-peer-id":"d2c3f297b56db0c4","added-peer-peer-urls":["https://199.204.45.122:2380"]}
{"level":"info","ts":"2026-02-22T17:48:57.252011Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-22T17:48:57.252164Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d2c3f297b56db0c4","initial-advertise-peer-urls":["https://199.204.45.122:2380"],"listen-peer-urls":["https://199.204.45.122:2380"],"advertise-client-urls":["https://199.204.45.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-22T17:48:57.252187Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-22T17:48:57.252228Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.122:2380"}
{"level":"info","ts":"2026-02-22T17:48:57.252248Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.122:2380"}
{"level":"info","ts":"2026-02-22T17:48:58.039557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-22T17:48:58.039621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-22T17:48:58.03966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgPreVoteResp from d2c3f297b56db0c4 at term 1"}
{"level":"info","ts":"2026-02-22T17:48:58.039686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became candidate at term 2"}
{"level":"info","ts":"2026-02-22T17:48:58.039724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgVoteResp from d2c3f297b56db0c4 at term 2"}
{"level":"info","ts":"2026-02-22T17:48:58.03974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became leader at term 2"}
{"level":"info","ts":"2026-02-22T17:48:58.039759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d2c3f297b56db0c4 elected leader d2c3f297b56db0c4 at term 2"}
{"level":"info","ts":"2026-02-22T17:48:58.04203Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d2c3f297b56db0c4","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.122:2379]}","request-path":"/0/members/d2c3f297b56db0c4/attributes","cluster-id":"becafec23d27c587","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-22T17:48:58.042394Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-22T17:48:58.042655Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-22T17:48:58.046213Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-22T17:48:58.046242Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-22T17:48:58.046371Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-22T17:48:58.049155Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"becafec23d27c587","local-member-id":"d2c3f297b56db0c4","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-22T17:48:58.049402Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-22T17:48:58.049452Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-22T17:48:58.049534Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-22T17:48:58.049829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.122:2379"}
{"level":"warn","ts":"2026-02-22T17:49:21.798133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.932088ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463428532 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.122\" mod_revision:361 > success:<request_put:<key:\"/registry/masterleases/199.204.45.122\" value_size:67 lease:3514105710608652718 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.122\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-22T17:49:21.798424Z","caller":"traceutil/trace.go:171","msg":"trace[1957628302] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"187.369739ms","start":"2026-02-22T17:49:21.61103Z","end":"2026-02-22T17:49:21.7984Z","steps":["trace[1957628302] 'process raft request'  (duration: 187.312257ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:49:21.798439Z","caller":"traceutil/trace.go:171","msg":"trace[66176921] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"190.342953ms","start":"2026-02-22T17:49:21.608041Z","end":"2026-02-22T17:49:21.798384Z","steps":["trace[66176921] 'process raft request'  (duration: 78.5011ms)","trace[66176921] 'compare'  (duration: 110.760962ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:21.798881Z","caller":"traceutil/trace.go:171","msg":"trace[851453316] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"187.853843ms","start":"2026-02-22T17:49:21.61097Z","end":"2026-02-22T17:49:21.798824Z","steps":["trace[851453316] 'process raft request'  (duration: 187.311218ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:49:27.931453Z","caller":"traceutil/trace.go:171","msg":"trace[944545280] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"106.803772ms","start":"2026-02-22T17:49:27.82461Z","end":"2026-02-22T17:49:27.931414Z","steps":["trace[944545280] 'read index received'  (duration: 106.607946ms)","trace[944545280] 'applied index is now lower than readState.Index'  (duration: 194.536µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:27.931585Z","caller":"traceutil/trace.go:171","msg":"trace[2114349981] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"266.449225ms","start":"2026-02-22T17:49:27.665106Z","end":"2026-02-22T17:49:27.931555Z","steps":["trace[2114349981] 'process raft request'  (duration: 266.091855ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:27.931652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.023748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-22T17:49:27.931693Z","caller":"traceutil/trace.go:171","msg":"trace[1027528502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:468; }","duration":"107.124781ms","start":"2026-02-22T17:49:27.824553Z","end":"2026-02-22T17:49:27.931677Z","steps":["trace[1027528502] 'agreement among raft nodes before linearized reading'  (duration: 107.033168ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:27.931867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.681931ms","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-02-22T17:49:27.932003Z","caller":"traceutil/trace.go:171","msg":"trace[857658080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:468; }","duration":"105.830775ms","start":"2026-02-22T17:49:27.826137Z","end":"2026-02-22T17:49:27.931968Z","steps":["trace[857658080] 'agreement among raft nodes before linearized reading'  (duration: 105.624109ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:31.019822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12737477747463428640,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-22T17:49:31.221031Z","caller":"traceutil/trace.go:171","msg":"trace[311604105] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"803.032206ms","start":"2026-02-22T17:49:30.417988Z","end":"2026-02-22T17:49:31.22102Z","steps":["trace[311604105] 'process raft request'  (duration: 802.873671ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:31.221131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:30.417958Z","time spent":"803.117198ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:418 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-22T17:49:31.221023Z","caller":"traceutil/trace.go:171","msg":"trace[1398138674] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"701.655786ms","start":"2026-02-22T17:49:30.519343Z","end":"2026-02-22T17:49:31.220998Z","steps":["trace[1398138674] 'read index received'  (duration: 701.494312ms)","trace[1398138674] 'applied index is now lower than readState.Index'  (duration: 160.774µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:49:31.221312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.958574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-22T17:49:31.221362Z","caller":"traceutil/trace.go:171","msg":"trace[17007239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"702.040117ms","start":"2026-02-22T17:49:30.519312Z","end":"2026-02-22T17:49:31.221352Z","steps":["trace[17007239] 'agreement among raft nodes before linearized reading'  (duration: 701.754149ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:31.221349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.888402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-22T17:49:31.221404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:30.519299Z","time spent":"702.097498ms","remote":"127.0.0.1:57114","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-02-22T17:49:31.22143Z","caller":"traceutil/trace.go:171","msg":"trace[852939479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"652.009635ms","start":"2026-02-22T17:49:30.569394Z","end":"2026-02-22T17:49:31.221403Z","steps":["trace[852939479] 'agreement among raft nodes before linearized reading'  (duration: 651.877092ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:31.22162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:30.569376Z","time spent":"652.230691ms","remote":"127.0.0.1:56846","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-02-22T17:49:35.601494Z","caller":"traceutil/trace.go:171","msg":"trace[1509939140] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"351.28677ms","start":"2026-02-22T17:49:35.250181Z","end":"2026-02-22T17:49:35.601468Z","steps":["trace[1509939140] 'read index received'  (duration: 351.004412ms)","trace[1509939140] 'applied index is now lower than readState.Index'  (duration: 281.318µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:35.601579Z","caller":"traceutil/trace.go:171","msg":"trace[1096496487] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"356.911157ms","start":"2026-02-22T17:49:35.244638Z","end":"2026-02-22T17:49:35.601549Z","steps":["trace[1096496487] 'process raft request'  (duration: 356.6659ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:35.601752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:35.24461Z","time spent":"357.042701ms","remote":"127.0.0.1:57114","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:482 > 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-02-22T17:49:35.601774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.574528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zc74r\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-22T17:49:35.601852Z","caller":"traceutil/trace.go:171","msg":"trace[1649606704] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zc74r; range_end:; response_count:1; response_revision:490; }","duration":"351.6584ms","start":"2026-02-22T17:49:35.250146Z","end":"2026-02-22T17:49:35.601804Z","steps":["trace[1649606704] 'agreement among raft nodes before linearized reading'  (duration: 351.466515ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:35.601894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:35.250129Z","time spent":"351.755713ms","remote":"127.0.0.1:57012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16680,"request content":"key:\"/registry/pods/kube-system/cilium-zc74r\" "}
{"level":"info","ts":"2026-02-22T17:49:36.05285Z","caller":"traceutil/trace.go:171","msg":"trace[900261802] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"435.704886ms","start":"2026-02-22T17:49:35.617124Z","end":"2026-02-22T17:49:36.052829Z","steps":["trace[900261802] 'process raft request'  (duration: 435.515091ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:36.053032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:35.617094Z","time spent":"435.87049ms","remote":"127.0.0.1:57012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-zc74r\" mod_revision:458 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-zc74r\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-zc74r\" > >"}
{"level":"warn","ts":"2026-02-22T17:49:37.272744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.61723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:49:37.272891Z","caller":"traceutil/trace.go:171","msg":"trace[1589952362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:494; }","duration":"698.725424ms","start":"2026-02-22T17:49:36.574081Z","end":"2026-02-22T17:49:37.272806Z","steps":["trace[1589952362] 'range keys from in-memory index tree'  (duration: 698.488507ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:37.272944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:36.574065Z","time spent":"698.867597ms","remote":"127.0.0.1:56846","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-02-22T17:49:37.617753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.772701ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463428691 > lease_revoke:<id:30c49c86780019ae>","response":"size:29"}
{"level":"info","ts":"2026-02-22T17:49:37.617831Z","caller":"traceutil/trace.go:171","msg":"trace[1551244208] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"344.038148ms","start":"2026-02-22T17:49:37.27378Z","end":"2026-02-22T17:49:37.617819Z","steps":["trace[1551244208] 'read index received'  (duration: 58.262µs)","trace[1551244208] 'applied index is now lower than readState.Index'  (duration: 343.978596ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:49:37.617911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.12675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:49:37.617924Z","caller":"traceutil/trace.go:171","msg":"trace[543159108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:494; }","duration":"344.180512ms","start":"2026-02-22T17:49:37.273739Z","end":"2026-02-22T17:49:37.61792Z","steps":["trace[543159108] 'agreement among raft nodes before linearized reading'  (duration: 344.14077ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:37.617943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:37.273709Z","time spent":"344.230653ms","remote":"127.0.0.1:56858","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-02-22T17:49:38.464958Z","caller":"traceutil/trace.go:171","msg":"trace[731576036] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"173.414568ms","start":"2026-02-22T17:49:38.291508Z","end":"2026-02-22T17:49:38.464922Z","steps":["trace[731576036] 'process raft request'  (duration: 95.337881ms)","trace[731576036] 'compare'  (duration: 77.926953ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:43.784981Z","caller":"traceutil/trace.go:171","msg":"trace[1946150824] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"156.69578ms","start":"2026-02-22T17:49:43.62824Z","end":"2026-02-22T17:49:43.784936Z","steps":["trace[1946150824] 'process raft request'  (duration: 153.607403ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:43.822399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.586682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-22T17:49:43.822492Z","caller":"traceutil/trace.go:171","msg":"trace[188661000] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:575; }","duration":"108.741376ms","start":"2026-02-22T17:49:43.713731Z","end":"2026-02-22T17:49:43.822472Z","steps":["trace[188661000] 'agreement among raft nodes before linearized reading'  (duration: 108.369846ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:44.005525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.111742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"}
{"level":"info","ts":"2026-02-22T17:49:44.005783Z","caller":"traceutil/trace.go:171","msg":"trace[1622168576] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:577; }","duration":"106.341329ms","start":"2026-02-22T17:49:43.899346Z","end":"2026-02-22T17:49:44.005687Z","steps":["trace[1622168576] 'range keys from in-memory index tree'  (duration: 105.951108ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:49:44.406009Z","caller":"traceutil/trace.go:171","msg":"trace[1826672235] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"118.50545ms","start":"2026-02-22T17:49:44.287464Z","end":"2026-02-22T17:49:44.405969Z","steps":["trace[1826672235] 'process raft request'  (duration: 118.095628ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:49:58.08868Z","caller":"traceutil/trace.go:171","msg":"trace[469343099] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:704; }","duration":"144.832618ms","start":"2026-02-22T17:49:57.943826Z","end":"2026-02-22T17:49:58.088659Z","steps":["trace[469343099] 'read index received'  (duration: 144.747835ms)","trace[469343099] 'applied index is now lower than readState.Index'  (duration: 83.582µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:58.088882Z","caller":"traceutil/trace.go:171","msg":"trace[2118596730] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"202.7317ms","start":"2026-02-22T17:49:57.88611Z","end":"2026-02-22T17:49:58.088841Z","steps":["trace[2118596730] 'process raft request'  (duration: 202.407531ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:58.088944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.088414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-22T17:49:58.089015Z","caller":"traceutil/trace.go:171","msg":"trace[549891764] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:683; }","duration":"145.207828ms","start":"2026-02-22T17:49:57.94379Z","end":"2026-02-22T17:49:58.088997Z","steps":["trace[549891764] 'agreement among raft nodes before linearized reading'  (duration: 145.007012ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:58.730504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12737477747463429051,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-22T17:49:58.795356Z","caller":"traceutil/trace.go:171","msg":"trace[1927308128] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"565.437529ms","start":"2026-02-22T17:49:58.22988Z","end":"2026-02-22T17:49:58.795318Z","steps":["trace[1927308128] 'read index received'  (duration: 565.057409ms)","trace[1927308128] 'applied index is now lower than readState.Index'  (duration: 378.12µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:58.79549Z","caller":"traceutil/trace.go:171","msg":"trace[1239478480] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"699.437433ms","start":"2026-02-22T17:49:58.095986Z","end":"2026-02-22T17:49:58.795423Z","steps":["trace[1239478480] 'process raft request'  (duration: 699.046132ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:58.795712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.802811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"warn","ts":"2026-02-22T17:49:58.795722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.205566ms","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-02-22T17:49:58.795705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.683412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-22T17:49:58.795722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.89032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-22T17:49:58.795766Z","caller":"traceutil/trace.go:171","msg":"trace[628287699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:684; }","duration":"565.901242ms","start":"2026-02-22T17:49:58.229846Z","end":"2026-02-22T17:49:58.795747Z","steps":["trace[628287699] 'agreement among raft nodes before linearized reading'  (duration: 565.659056ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:58.795752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:58.095943Z","time spent":"699.67094ms","remote":"127.0.0.1:57114","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:679 > 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-02-22T17:49:58.796419Z","caller":"traceutil/trace.go:171","msg":"trace[1296986385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:684; }","duration":"478.301079ms","start":"2026-02-22T17:49:58.317462Z","end":"2026-02-22T17:49:58.795763Z","steps":["trace[1296986385] 'agreement among raft nodes before linearized reading'  (duration: 478.132964ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:58.79629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:58.229828Z","time spent":"565.974765ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-22T17:49:58.796486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:58.317452Z","time spent":"479.020069ms","remote":"127.0.0.1:57114","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":"info","ts":"2026-02-22T17:49:58.79579Z","caller":"traceutil/trace.go:171","msg":"trace[1544121245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"225.779245ms","start":"2026-02-22T17:49:58.569992Z","end":"2026-02-22T17:49:58.795771Z","steps":["trace[1544121245] 'agreement among raft nodes before linearized reading'  (duration: 225.59046ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:49:58.796635Z","caller":"traceutil/trace.go:171","msg":"trace[768258211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:684; }","duration":"482.016153ms","start":"2026-02-22T17:49:58.313761Z","end":"2026-02-22T17:49:58.795777Z","steps":["trace[768258211] 'agreement among raft nodes before linearized reading'  (duration: 481.801317ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:49:58.796666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:49:58.313741Z","time spent":"482.916728ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-22T17:49:58.92607Z","caller":"traceutil/trace.go:171","msg":"trace[2126034722] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"122.313497ms","start":"2026-02-22T17:49:58.803701Z","end":"2026-02-22T17:49:58.926015Z","steps":["trace[2126034722] 'process raft request'  (duration: 92.340657ms)","trace[2126034722] 'compare'  (duration: 29.759334ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:49:58.926229Z","caller":"traceutil/trace.go:171","msg":"trace[1566138230] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"121.687729ms","start":"2026-02-22T17:49:58.804516Z","end":"2026-02-22T17:49:58.926204Z","steps":["trace[1566138230] 'process raft request'  (duration: 121.400261ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:21.153458Z","caller":"traceutil/trace.go:171","msg":"trace[1931529133] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"118.015739ms","start":"2026-02-22T17:50:21.035413Z","end":"2026-02-22T17:50:21.153428Z","steps":["trace[1931529133] 'process raft request'  (duration: 117.833974ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:21.158796Z","caller":"traceutil/trace.go:171","msg":"trace[1041257298] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"119.207492ms","start":"2026-02-22T17:50:21.039562Z","end":"2026-02-22T17:50:21.158769Z","steps":["trace[1041257298] 'process raft request'  (duration: 119.095529ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:23.424201Z","caller":"traceutil/trace.go:171","msg":"trace[1087257741] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"451.743169ms","start":"2026-02-22T17:50:22.972437Z","end":"2026-02-22T17:50:23.42418Z","steps":["trace[1087257741] 'read index received'  (duration: 451.586685ms)","trace[1087257741] 'applied index is now lower than readState.Index'  (duration: 155.814µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:23.424254Z","caller":"traceutil/trace.go:171","msg":"trace[465947889] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"473.607278ms","start":"2026-02-22T17:50:22.95063Z","end":"2026-02-22T17:50:23.424237Z","steps":["trace[465947889] 'process raft request'  (duration: 473.415512ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:23.424365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:22.950588Z","time spent":"473.704591ms","remote":"127.0.0.1:57114","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:751 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:50:23.424421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.977615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-22T17:50:23.424451Z","caller":"traceutil/trace.go:171","msg":"trace[887504576] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:758; }","duration":"452.023446ms","start":"2026-02-22T17:50:22.972418Z","end":"2026-02-22T17:50:23.424442Z","steps":["trace[887504576] 'agreement among raft nodes before linearized reading'  (duration: 451.885582ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:23.424472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:22.972411Z","time spent":"452.056857ms","remote":"127.0.0.1:57114","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-02-22T17:50:23.424692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.499784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-22T17:50:23.424724Z","caller":"traceutil/trace.go:171","msg":"trace[927759463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:758; }","duration":"267.571126ms","start":"2026-02-22T17:50:23.157146Z","end":"2026-02-22T17:50:23.424718Z","steps":["trace[927759463] 'agreement among raft nodes before linearized reading'  (duration: 267.481954ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:23.424695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.132475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-22T17:50:23.42478Z","caller":"traceutil/trace.go:171","msg":"trace[880497475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:758; }","duration":"262.261429ms","start":"2026-02-22T17:50:23.162514Z","end":"2026-02-22T17:50:23.424776Z","steps":["trace[880497475] 'agreement among raft nodes before linearized reading'  (duration: 262.139815ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:24.04834Z","caller":"traceutil/trace.go:171","msg":"trace[310265004] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"620.324997ms","start":"2026-02-22T17:50:23.427991Z","end":"2026-02-22T17:50:24.048316Z","steps":["trace[310265004] 'process raft request'  (duration: 620.172963ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:24.048599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:23.427943Z","time spent":"620.555353ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:753 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-22T17:50:24.298809Z","caller":"traceutil/trace.go:171","msg":"trace[1131148406] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:785; }","duration":"729.092587ms","start":"2026-02-22T17:50:23.569682Z","end":"2026-02-22T17:50:24.298774Z","steps":["trace[1131148406] 'read index received'  (duration: 478.551796ms)","trace[1131148406] 'applied index is now lower than readState.Index'  (duration: 250.539911ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:24.298866Z","caller":"traceutil/trace.go:171","msg":"trace[613228844] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"870.292483ms","start":"2026-02-22T17:50:23.428531Z","end":"2026-02-22T17:50:24.298824Z","steps":["trace[613228844] 'process raft request'  (duration: 870.155819ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:24.299077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.386536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:24.299138Z","caller":"traceutil/trace.go:171","msg":"trace[122477348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"729.521319ms","start":"2026-02-22T17:50:23.569604Z","end":"2026-02-22T17:50:24.299125Z","steps":["trace[122477348] 'agreement among raft nodes before linearized reading'  (duration: 729.389346ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:24.299217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:23.569579Z","time spent":"729.626842ms","remote":"127.0.0.1:56846","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-02-22T17:50:24.299131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:23.428527Z","time spent":"870.495018ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:754 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-22T17:50:24.299307Z","caller":"traceutil/trace.go:171","msg":"trace[1928990577] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"870.728825ms","start":"2026-02-22T17:50:23.428491Z","end":"2026-02-22T17:50:24.29922Z","steps":["trace[1928990577] 'process raft request'  (duration: 784.008898ms)","trace[1928990577] 'compare'  (duration: 85.918424ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:50:24.299639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:23.428482Z","time spent":"870.960311ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:752 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-22T17:50:25.788258Z","caller":"traceutil/trace.go:171","msg":"trace[196608688] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:789; }","duration":"359.661402ms","start":"2026-02-22T17:50:25.428574Z","end":"2026-02-22T17:50:25.788235Z","steps":["trace[196608688] 'read index received'  (duration: 359.418696ms)","trace[196608688] 'applied index is now lower than readState.Index'  (duration: 241.666µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:25.788359Z","caller":"traceutil/trace.go:171","msg":"trace[1364004995] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"455.155533ms","start":"2026-02-22T17:50:25.333136Z","end":"2026-02-22T17:50:25.788292Z","steps":["trace[1364004995] 'process raft request'  (duration: 454.920636ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:25.788486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.527398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:25.78853Z","caller":"traceutil/trace.go:171","msg":"trace[557043486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"218.660302ms","start":"2026-02-22T17:50:25.569858Z","end":"2026-02-22T17:50:25.788518Z","steps":["trace[557043486] 'agreement among raft nodes before linearized reading'  (duration: 218.536289ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:25.788585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.990401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-02-22T17:50:25.788663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:25.333111Z","time spent":"455.40499ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:739 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-22T17:50:25.788675Z","caller":"traceutil/trace.go:171","msg":"trace[1308686357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:763; }","duration":"360.133305ms","start":"2026-02-22T17:50:25.428522Z","end":"2026-02-22T17:50:25.788655Z","steps":["trace[1308686357] 'agreement among raft nodes before linearized reading'  (duration: 359.868988ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:25.788839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:25.428506Z","time spent":"360.32072ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-22T17:50:25.995767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.375093ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429279 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:758 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-22T17:50:25.995893Z","caller":"traceutil/trace.go:171","msg":"trace[1903863820] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"202.078071ms","start":"2026-02-22T17:50:25.793777Z","end":"2026-02-22T17:50:25.995855Z","steps":["trace[1903863820] 'process raft request'  (duration: 99.531933ms)","trace[1903863820] 'compare'  (duration: 102.26627ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:26.345544Z","caller":"traceutil/trace.go:171","msg":"trace[613586427] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"289.828367ms","start":"2026-02-22T17:50:26.055686Z","end":"2026-02-22T17:50:26.345515Z","steps":["trace[613586427] 'process raft request'  (duration: 289.665232ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:27.475586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.499154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:27.475675Z","caller":"traceutil/trace.go:171","msg":"trace[14194797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"905.629997ms","start":"2026-02-22T17:50:26.570023Z","end":"2026-02-22T17:50:27.475653Z","steps":["trace[14194797] 'range keys from in-memory index tree'  (duration: 905.414981ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:27.475715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:26.570002Z","time spent":"905.704369ms","remote":"127.0.0.1:56846","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-02-22T17:50:27.755482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.648001ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429289 > lease_revoke:<id:30c49c8678001c38>","response":"size:29"}
{"level":"info","ts":"2026-02-22T17:50:27.755614Z","caller":"traceutil/trace.go:171","msg":"trace[365888167] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"1.031297699s","start":"2026-02-22T17:50:26.724286Z","end":"2026-02-22T17:50:27.755584Z","steps":["trace[365888167] 'read index received'  (duration: 436.464913ms)","trace[365888167] 'applied index is now lower than readState.Index'  (duration: 594.831276ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:50:27.75576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031468794s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-22T17:50:27.755789Z","caller":"traceutil/trace.go:171","msg":"trace[441183072] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:768; }","duration":"1.031552787s","start":"2026-02-22T17:50:26.724226Z","end":"2026-02-22T17:50:27.755779Z","steps":["trace[441183072] 'agreement among raft nodes before linearized reading'  (duration: 1.031469814s)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:27.755828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:26.724193Z","time spent":"1.031624049s","remote":"127.0.0.1:57268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-02-22T17:50:27.755837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.859391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:27.755927Z","caller":"traceutil/trace.go:171","msg":"trace[1904186164] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"279.005895ms","start":"2026-02-22T17:50:27.476899Z","end":"2026-02-22T17:50:27.755905Z","steps":["trace[1904186164] 'agreement among raft nodes before linearized reading'  (duration: 278.845751ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:28.335565Z","caller":"traceutil/trace.go:171","msg":"trace[1168264562] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"330.463168ms","start":"2026-02-22T17:50:28.005077Z","end":"2026-02-22T17:50:28.33554Z","steps":["trace[1168264562] 'process raft request'  (duration: 330.295534ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:28.335711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:28.005056Z","time spent":"330.579992ms","remote":"127.0.0.1:57114","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:764 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:50:28.614311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.299607ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429296 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:765 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-22T17:50:28.614383Z","caller":"traceutil/trace.go:171","msg":"trace[1463412919] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"183.40727ms","start":"2026-02-22T17:50:28.430964Z","end":"2026-02-22T17:50:28.614371Z","steps":["trace[1463412919] 'read index received'  (duration: 42.841µs)","trace[1463412919] 'applied index is now lower than readState.Index'  (duration: 183.363699ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:28.614456Z","caller":"traceutil/trace.go:171","msg":"trace[1519114034] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"260.260033ms","start":"2026-02-22T17:50:28.354189Z","end":"2026-02-22T17:50:28.614449Z","steps":["trace[1519114034] 'process raft request'  (duration: 43.7625ms)","trace[1519114034] 'compare'  (duration: 216.222005ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:50:28.614645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.689399ms","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-02-22T17:50:28.614664Z","caller":"traceutil/trace.go:171","msg":"trace[1724889844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:770; }","duration":"183.74712ms","start":"2026-02-22T17:50:28.430911Z","end":"2026-02-22T17:50:28.614658Z","steps":["trace[1724889844] 'agreement among raft nodes before linearized reading'  (duration: 183.663978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:28.614749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.835485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-22T17:50:28.614779Z","caller":"traceutil/trace.go:171","msg":"trace[522742234] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:770; }","duration":"177.930838ms","start":"2026-02-22T17:50:28.436844Z","end":"2026-02-22T17:50:28.614775Z","steps":["trace[522742234] 'agreement among raft nodes before linearized reading'  (duration: 177.875936ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:28.615093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.23778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-22T17:50:28.615166Z","caller":"traceutil/trace.go:171","msg":"trace[413985046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:770; }","duration":"153.360634ms","start":"2026-02-22T17:50:28.461788Z","end":"2026-02-22T17:50:28.615148Z","steps":["trace[413985046] 'agreement among raft nodes before linearized reading'  (duration: 153.083506ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:28.965494Z","caller":"traceutil/trace.go:171","msg":"trace[19731526] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"347.533805ms","start":"2026-02-22T17:50:28.617936Z","end":"2026-02-22T17:50:28.96547Z","steps":["trace[19731526] 'process raft request'  (duration: 347.402211ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:28.965653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:28.617915Z","time spent":"347.652948ms","remote":"127.0.0.1:57114","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:768 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-22T17:50:29.0034Z","caller":"traceutil/trace.go:171","msg":"trace[1545768488] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"385.347769ms","start":"2026-02-22T17:50:28.618029Z","end":"2026-02-22T17:50:29.003377Z","steps":["trace[1545768488] 'process raft request'  (duration: 385.117333ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:29.00367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:28.618016Z","time spent":"385.452512ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:767 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-22T17:50:29.003399Z","caller":"traceutil/trace.go:171","msg":"trace[207579244] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"384.810943ms","start":"2026-02-22T17:50:28.618534Z","end":"2026-02-22T17:50:29.003345Z","steps":["trace[207579244] 'process raft request'  (duration: 384.751131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:29.004268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:28.618514Z","time spent":"385.684148ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:766 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:50:32.69719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.354357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-22T17:50:32.697318Z","caller":"traceutil/trace.go:171","msg":"trace[2115451936] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:780; }","duration":"114.533562ms","start":"2026-02-22T17:50:32.582755Z","end":"2026-02-22T17:50:32.697289Z","steps":["trace[2115451936] 'count revisions from in-memory index tree'  (duration: 114.281064ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:32.697199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.202902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:32.697425Z","caller":"traceutil/trace.go:171","msg":"trace[311095400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"114.445849ms","start":"2026-02-22T17:50:32.582948Z","end":"2026-02-22T17:50:32.697394Z","steps":["trace[311095400] 'range keys from in-memory index tree'  (duration: 114.061948ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:41.528505Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12737477747463429488,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-22T17:50:41.793116Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.052330465s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-22T17:50:41.793626Z","caller":"traceutil/trace.go:171","msg":"trace[496637225] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:885; }","duration":"765.804561ms","start":"2026-02-22T17:50:41.02779Z","end":"2026-02-22T17:50:41.793594Z","steps":["trace[496637225] 'read index received'  (duration: 765.531393ms)","trace[496637225] 'applied index is now lower than readState.Index'  (duration: 268.098µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:41.793741Z","caller":"traceutil/trace.go:171","msg":"trace[890388402] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"1.053096966s","start":"2026-02-22T17:50:40.740629Z","end":"2026-02-22T17:50:41.793726Z","steps":["trace[890388402] 'process raft request'  (duration: 1.052760877s)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:41.793923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:40.740596Z","time spent":"1.053187319s","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:849 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:50:41.794008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.020161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-22T17:50:41.794101Z","caller":"traceutil/trace.go:171","msg":"trace[667136780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:854; }","duration":"731.159515ms","start":"2026-02-22T17:50:41.062916Z","end":"2026-02-22T17:50:41.794076Z","steps":["trace[667136780] 'agreement among raft nodes before linearized reading'  (duration: 730.939869ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:41.79415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:41.062897Z","time spent":"731.244308ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-22T17:50:41.794353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.574112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-22T17:50:41.794387Z","caller":"traceutil/trace.go:171","msg":"trace[167929372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:854; }","duration":"766.651664ms","start":"2026-02-22T17:50:41.027726Z","end":"2026-02-22T17:50:41.794377Z","steps":["trace[167929372] 'agreement among raft nodes before linearized reading'  (duration: 766.568531ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:41.794419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:41.027698Z","time spent":"766.715576ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-22T17:50:41.794608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.11243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.122\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-02-22T17:50:41.794678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.231357ms","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-02-22T17:50:41.794692Z","caller":"traceutil/trace.go:171","msg":"trace[1988614344] range","detail":"{range_begin:/registry/masterleases/199.204.45.122; range_end:; response_count:1; response_revision:854; }","duration":"245.245645ms","start":"2026-02-22T17:50:41.549429Z","end":"2026-02-22T17:50:41.794675Z","steps":["trace[1988614344] 'agreement among raft nodes before linearized reading'  (duration: 245.022489ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:41.794729Z","caller":"traceutil/trace.go:171","msg":"trace[1399511442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:854; }","duration":"731.316489ms","start":"2026-02-22T17:50:41.063401Z","end":"2026-02-22T17:50:41.794718Z","steps":["trace[1399511442] 'agreement among raft nodes before linearized reading'  (duration: 731.166845ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:41.794766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:41.063385Z","time spent":"731.373001ms","remote":"127.0.0.1:57114","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":"warn","ts":"2026-02-22T17:50:41.794908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.933908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:41.794948Z","caller":"traceutil/trace.go:171","msg":"trace[1907862142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:854; }","duration":"224.99105ms","start":"2026-02-22T17:50:41.569946Z","end":"2026-02-22T17:50:41.794937Z","steps":["trace[1907862142] 'agreement among raft nodes before linearized reading'  (duration: 224.929798ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:41.948826Z","caller":"traceutil/trace.go:171","msg":"trace[223583996] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"149.031683ms","start":"2026-02-22T17:50:41.79977Z","end":"2026-02-22T17:50:41.948802Z","steps":["trace[223583996] 'process raft request'  (duration: 148.868488ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:41.949165Z","caller":"traceutil/trace.go:171","msg":"trace[803517307] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"149.272239ms","start":"2026-02-22T17:50:41.799866Z","end":"2026-02-22T17:50:41.949138Z","steps":["trace[803517307] 'process raft request'  (duration: 148.896089ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:41.949258Z","caller":"traceutil/trace.go:171","msg":"trace[1931696172] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"149.161457ms","start":"2026-02-22T17:50:41.800067Z","end":"2026-02-22T17:50:41.949228Z","steps":["trace[1931696172] 'process raft request'  (duration: 149.009953ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:56.244827Z","caller":"traceutil/trace.go:171","msg":"trace[1821552692] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"211.542595ms","start":"2026-02-22T17:50:56.033262Z","end":"2026-02-22T17:50:56.244805Z","steps":["trace[1821552692] 'process raft request'  (duration: 211.415401ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:56.269383Z","caller":"traceutil/trace.go:171","msg":"trace[914625879] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:929; }","duration":"235.474832ms","start":"2026-02-22T17:50:56.033891Z","end":"2026-02-22T17:50:56.269366Z","steps":["trace[914625879] 'read index received'  (duration: 210.752643ms)","trace[914625879] 'applied index is now lower than readState.Index'  (duration: 24.721529ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:50:56.269537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.636616ms","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-02-22T17:50:56.26956Z","caller":"traceutil/trace.go:171","msg":"trace[1006063780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:896; }","duration":"235.704348ms","start":"2026-02-22T17:50:56.033848Z","end":"2026-02-22T17:50:56.269553Z","steps":["trace[1006063780] 'agreement among raft nodes before linearized reading'  (duration: 235.580695ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:56.269737Z","caller":"traceutil/trace.go:171","msg":"trace[1327003330] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"236.340246ms","start":"2026-02-22T17:50:56.033391Z","end":"2026-02-22T17:50:56.269731Z","steps":["trace[1327003330] 'process raft request'  (duration: 235.890984ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:56.71368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.449404ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429608 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:892 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-22T17:50:56.713791Z","caller":"traceutil/trace.go:171","msg":"trace[882440167] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"211.137513ms","start":"2026-02-22T17:50:56.502636Z","end":"2026-02-22T17:50:56.713773Z","steps":["trace[882440167] 'read index received'  (duration: 19.06µs)","trace[882440167] 'applied index is now lower than readState.Index'  (duration: 211.117283ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:56.713887Z","caller":"traceutil/trace.go:171","msg":"trace[526438403] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"439.97168ms","start":"2026-02-22T17:50:56.273904Z","end":"2026-02-22T17:50:56.713875Z","steps":["trace[526438403] 'process raft request'  (duration: 74.225248ms)","trace[526438403] 'compare'  (duration: 365.210747ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:50:56.713962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:50:56.273884Z","time spent":"440.041393ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:892 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-22T17:50:56.714278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.622107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-22T17:50:56.714357Z","caller":"traceutil/trace.go:171","msg":"trace[1643004089] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:897; }","duration":"211.74902ms","start":"2026-02-22T17:50:56.502591Z","end":"2026-02-22T17:50:56.71434Z","steps":["trace[1643004089] 'agreement among raft nodes before linearized reading'  (duration: 211.543384ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:56.717203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.949293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:56.717288Z","caller":"traceutil/trace.go:171","msg":"trace[844535345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"148.139288ms","start":"2026-02-22T17:50:56.569131Z","end":"2026-02-22T17:50:56.71727Z","steps":["trace[844535345] 'agreement among raft nodes before linearized reading'  (duration: 147.907641ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:56.717465Z","caller":"traceutil/trace.go:171","msg":"trace[1204162244] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"108.185275ms","start":"2026-02-22T17:50:56.609261Z","end":"2026-02-22T17:50:56.717446Z","steps":["trace[1204162244] 'process raft request'  (duration: 107.67649ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:50:59.901163Z","caller":"traceutil/trace.go:171","msg":"trace[1106487478] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"197.770091ms","start":"2026-02-22T17:50:59.703374Z","end":"2026-02-22T17:50:59.901144Z","steps":["trace[1106487478] 'read index received'  (duration: 197.614487ms)","trace[1106487478] 'applied index is now lower than readState.Index'  (duration: 155.124µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:50:59.901215Z","caller":"traceutil/trace.go:171","msg":"trace[1362796717] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"281.237357ms","start":"2026-02-22T17:50:59.619951Z","end":"2026-02-22T17:50:59.901189Z","steps":["trace[1362796717] 'process raft request'  (duration: 281.087062ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:50:59.901274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.895054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:50:59.9013Z","caller":"traceutil/trace.go:171","msg":"trace[431670048] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:921; }","duration":"197.974446ms","start":"2026-02-22T17:50:59.703319Z","end":"2026-02-22T17:50:59.901293Z","steps":["trace[431670048] 'agreement among raft nodes before linearized reading'  (duration: 197.918115ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:00.082974Z","caller":"traceutil/trace.go:171","msg":"trace[1640427383] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"175.864301ms","start":"2026-02-22T17:50:59.907086Z","end":"2026-02-22T17:51:00.08295Z","steps":["trace[1640427383] 'process raft request'  (duration: 95.172512ms)","trace[1640427383] 'compare'  (duration: 80.276627ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:00.083264Z","caller":"traceutil/trace.go:171","msg":"trace[676656145] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"176.090677ms","start":"2026-02-22T17:50:59.907162Z","end":"2026-02-22T17:51:00.083253Z","steps":["trace[676656145] 'process raft request'  (duration: 175.734277ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:00.083336Z","caller":"traceutil/trace.go:171","msg":"trace[561484213] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"173.422773ms","start":"2026-02-22T17:50:59.909885Z","end":"2026-02-22T17:51:00.083308Z","steps":["trace[561484213] 'process raft request'  (duration: 173.277909ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.175361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.066825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:01.175418Z","caller":"traceutil/trace.go:171","msg":"trace[1596767454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:927; }","duration":"608.159938ms","start":"2026-02-22T17:51:00.567244Z","end":"2026-02-22T17:51:01.175404Z","steps":["trace[1596767454] 'range keys from in-memory index tree'  (duration: 608.001783ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.17544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:00.567229Z","time spent":"608.207039ms","remote":"127.0.0.1:56858","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-02-22T17:51:01.175653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.879385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-22T17:51:01.175671Z","caller":"traceutil/trace.go:171","msg":"trace[432815516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:927; }","duration":"445.920516ms","start":"2026-02-22T17:51:00.729747Z","end":"2026-02-22T17:51:01.175667Z","steps":["trace[432815516] 'range keys from in-memory index tree'  (duration: 445.785312ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.175685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:00.729736Z","time spent":"445.945087ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-22T17:51:01.175729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.004368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-22T17:51:01.175822Z","caller":"traceutil/trace.go:171","msg":"trace[43961391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:927; }","duration":"451.157983ms","start":"2026-02-22T17:51:00.724627Z","end":"2026-02-22T17:51:01.175785Z","steps":["trace[43961391] 'range keys from in-memory index tree'  (duration: 450.857695ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.175882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:00.724607Z","time spent":"451.252215ms","remote":"127.0.0.1:57114","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":"info","ts":"2026-02-22T17:51:01.524935Z","caller":"traceutil/trace.go:171","msg":"trace[35103794] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"344.563881ms","start":"2026-02-22T17:51:01.180346Z","end":"2026-02-22T17:51:01.52491Z","steps":["trace[35103794] 'process raft request'  (duration: 344.414597ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.526045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:01.180325Z","time spent":"345.653411ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:917 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-22T17:51:01.74917Z","caller":"traceutil/trace.go:171","msg":"trace[1864190861] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"198.622135ms","start":"2026-02-22T17:51:01.550528Z","end":"2026-02-22T17:51:01.74915Z","steps":["trace[1864190861] 'read index received'  (duration: 198.412599ms)","trace[1864190861] 'applied index is now lower than readState.Index'  (duration: 208.956µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:01.74952Z","caller":"traceutil/trace.go:171","msg":"trace[1803992443] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"567.999277ms","start":"2026-02-22T17:51:01.181495Z","end":"2026-02-22T17:51:01.749494Z","steps":["trace[1803992443] 'process raft request'  (duration: 567.501443ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.749663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:01.181482Z","time spent":"568.108671ms","remote":"127.0.0.1:57114","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:918 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:01.749865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.334944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.122\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-22T17:51:01.749896Z","caller":"traceutil/trace.go:171","msg":"trace[2010434649] range","detail":"{range_begin:/registry/masterleases/199.204.45.122; range_end:; response_count:1; response_revision:929; }","duration":"199.392006ms","start":"2026-02-22T17:51:01.550493Z","end":"2026-02-22T17:51:01.749885Z","steps":["trace[2010434649] 'agreement among raft nodes before linearized reading'  (duration: 199.273683ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:01.749913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.51471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:01.74995Z","caller":"traceutil/trace.go:171","msg":"trace[1999776664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:929; }","duration":"180.598222ms","start":"2026-02-22T17:51:01.569341Z","end":"2026-02-22T17:51:01.749939Z","steps":["trace[1999776664] 'agreement among raft nodes before linearized reading'  (duration: 180.52786ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:01.955797Z","caller":"traceutil/trace.go:171","msg":"trace[1804524385] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"151.351838ms","start":"2026-02-22T17:51:01.804416Z","end":"2026-02-22T17:51:01.955768Z","steps":["trace[1804524385] 'process raft request'  (duration: 85.583084ms)","trace[1804524385] 'compare'  (duration: 65.65756ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:02.535588Z","caller":"traceutil/trace.go:171","msg":"trace[1883211234] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"124.486239ms","start":"2026-02-22T17:51:02.411071Z","end":"2026-02-22T17:51:02.535558Z","steps":["trace[1883211234] 'process raft request'  (duration: 124.312974ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:02.737837Z","caller":"traceutil/trace.go:171","msg":"trace[535954699] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"223.694823ms","start":"2026-02-22T17:51:02.514114Z","end":"2026-02-22T17:51:02.737809Z","steps":["trace[535954699] 'process raft request'  (duration: 223.511168ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:04.008057Z","caller":"traceutil/trace.go:171","msg":"trace[101202970] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:971; }","duration":"440.109794ms","start":"2026-02-22T17:51:03.567924Z","end":"2026-02-22T17:51:04.008034Z","steps":["trace[101202970] 'read index received'  (duration: 440.033142ms)","trace[101202970] 'applied index is now lower than readState.Index'  (duration: 75.392µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:04.008152Z","caller":"traceutil/trace.go:171","msg":"trace[2131209257] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"472.984631ms","start":"2026-02-22T17:51:03.535138Z","end":"2026-02-22T17:51:04.008123Z","steps":["trace[2131209257] 'process raft request'  (duration: 472.764425ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:04.008195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.250928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:04.008229Z","caller":"traceutil/trace.go:171","msg":"trace[1928217460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:935; }","duration":"440.346311ms","start":"2026-02-22T17:51:03.567873Z","end":"2026-02-22T17:51:04.008219Z","steps":["trace[1928217460] 'agreement among raft nodes before linearized reading'  (duration: 440.273599ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:04.008262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:03.567849Z","time spent":"440.405482ms","remote":"127.0.0.1:56846","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-02-22T17:51:04.008276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:03.53512Z","time spent":"473.089743ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:928 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:04.494789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.337469ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429685 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:888 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-22T17:51:04.49489Z","caller":"traceutil/trace.go:171","msg":"trace[558918350] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:972; }","duration":"486.751794ms","start":"2026-02-22T17:51:04.00812Z","end":"2026-02-22T17:51:04.494872Z","steps":["trace[558918350] 'read index received'  (duration: 256.284161ms)","trace[558918350] 'applied index is now lower than readState.Index'  (duration: 230.466553ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:04.494971Z","caller":"traceutil/trace.go:171","msg":"trace[478569528] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"871.570268ms","start":"2026-02-22T17:51:03.62339Z","end":"2026-02-22T17:51:04.49496Z","steps":["trace[478569528] 'process raft request'  (duration: 640.979782ms)","trace[478569528] 'compare'  (duration: 230.163044ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:51:04.495023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:03.623369Z","time spent":"871.624659ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:888 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:04.495044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.415047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:04.495112Z","caller":"traceutil/trace.go:171","msg":"trace[1085858189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:936; }","duration":"485.52621ms","start":"2026-02-22T17:51:04.009568Z","end":"2026-02-22T17:51:04.495095Z","steps":["trace[1085858189] 'agreement among raft nodes before linearized reading'  (duration: 485.428707ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:04.495147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:04.009549Z","time spent":"485.591662ms","remote":"127.0.0.1:56858","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-02-22T17:51:04.495423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.499017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-22T17:51:04.495459Z","caller":"traceutil/trace.go:171","msg":"trace[534730643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:936; }","duration":"477.571309ms","start":"2026-02-22T17:51:04.017877Z","end":"2026-02-22T17:51:04.495448Z","steps":["trace[534730643] 'agreement among raft nodes before linearized reading'  (duration: 477.447865ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:04.495518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:04.017856Z","time spent":"477.655441ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-22T17:51:04.49555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.215875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-22T17:51:04.495586Z","caller":"traceutil/trace.go:171","msg":"trace[129929432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:936; }","duration":"741.280187ms","start":"2026-02-22T17:51:03.754295Z","end":"2026-02-22T17:51:04.495575Z","steps":["trace[129929432] 'agreement among raft nodes before linearized reading'  (duration: 741.00899ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:04.495614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:03.754279Z","time spent":"741.327968ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-22T17:51:04.69679Z","caller":"traceutil/trace.go:171","msg":"trace[1172719976] linearizableReadLoop","detail":"{readStateIndex:977; appliedIndex:976; }","duration":"123.168239ms","start":"2026-02-22T17:51:04.573584Z","end":"2026-02-22T17:51:04.696753Z","steps":["trace[1172719976] 'read index received'  (duration: 123.041045ms)","trace[1172719976] 'applied index is now lower than readState.Index'  (duration: 126.144µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:04.696813Z","caller":"traceutil/trace.go:171","msg":"trace[1256701369] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"138.950969ms","start":"2026-02-22T17:51:04.557829Z","end":"2026-02-22T17:51:04.69678Z","steps":["trace[1256701369] 'process raft request'  (duration: 138.748543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:04.696955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.351774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:04.696999Z","caller":"traceutil/trace.go:171","msg":"trace[1967728077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:940; }","duration":"123.434326ms","start":"2026-02-22T17:51:04.573553Z","end":"2026-02-22T17:51:04.696987Z","steps":["trace[1967728077] 'agreement among raft nodes before linearized reading'  (duration: 123.334984ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:04.727152Z","caller":"traceutil/trace.go:171","msg":"trace[1366782093] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"151.503116ms","start":"2026-02-22T17:51:04.575617Z","end":"2026-02-22T17:51:04.72712Z","steps":["trace[1366782093] 'process raft request'  (duration: 151.324001ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:04.854807Z","caller":"traceutil/trace.go:171","msg":"trace[1673654012] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"103.857466ms","start":"2026-02-22T17:51:04.750921Z","end":"2026-02-22T17:51:04.854779Z","steps":["trace[1673654012] 'process raft request'  (duration: 103.425624ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:04.854806Z","caller":"traceutil/trace.go:171","msg":"trace[887234034] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"103.555328ms","start":"2026-02-22T17:51:04.751232Z","end":"2026-02-22T17:51:04.854787Z","steps":["trace[887234034] 'process raft request'  (duration: 103.501257ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:06.413464Z","caller":"traceutil/trace.go:171","msg":"trace[2090035961] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"400.844382ms","start":"2026-02-22T17:51:06.012595Z","end":"2026-02-22T17:51:06.41344Z","steps":["trace[2090035961] 'read index received'  (duration: 400.628556ms)","trace[2090035961] 'applied index is now lower than readState.Index'  (duration: 214.846µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:06.413561Z","caller":"traceutil/trace.go:171","msg":"trace[60549762] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"543.867558ms","start":"2026-02-22T17:51:05.869648Z","end":"2026-02-22T17:51:06.413515Z","steps":["trace[60549762] 'process raft request'  (duration: 543.634912ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:06.413732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.12856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-22T17:51:06.413777Z","caller":"traceutil/trace.go:171","msg":"trace[1053867547] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:947; }","duration":"401.259534ms","start":"2026-02-22T17:51:06.012507Z","end":"2026-02-22T17:51:06.413766Z","steps":["trace[1053867547] 'agreement among raft nodes before linearized reading'  (duration: 401.026938ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:06.41378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:05.869622Z","time spent":"544.046694ms","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5382,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:919 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5348 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:06.413816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:06.012456Z","time spent":"401.350806ms","remote":"127.0.0.1:57114","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-02-22T17:51:06.805473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.665013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:06.805551Z","caller":"traceutil/trace.go:171","msg":"trace[2114837123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:948; }","duration":"234.835688ms","start":"2026-02-22T17:51:06.570698Z","end":"2026-02-22T17:51:06.805533Z","steps":["trace[2114837123] 'range keys from in-memory index tree'  (duration: 234.582831ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:06.805544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.390909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-22T17:51:06.805584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.624352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-22T17:51:06.805655Z","caller":"traceutil/trace.go:171","msg":"trace[1385466586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:948; }","duration":"252.744806ms","start":"2026-02-22T17:51:06.552894Z","end":"2026-02-22T17:51:06.805639Z","steps":["trace[1385466586] 'range keys from in-memory index tree'  (duration: 252.438928ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:06.805643Z","caller":"traceutil/trace.go:171","msg":"trace[72064254] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:948; }","duration":"105.562115ms","start":"2026-02-22T17:51:06.700054Z","end":"2026-02-22T17:51:06.805617Z","steps":["trace[72064254] 'count revisions from in-memory index tree'  (duration: 105.297047ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:06.805676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.546493ms","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-02-22T17:51:06.805753Z","caller":"traceutil/trace.go:171","msg":"trace[1361130414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:948; }","duration":"228.676837ms","start":"2026-02-22T17:51:06.577059Z","end":"2026-02-22T17:51:06.805736Z","steps":["trace[1361130414] 'range keys from in-memory index tree'  (duration: 228.224175ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:06.805831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.021458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-22T17:51:06.805867Z","caller":"traceutil/trace.go:171","msg":"trace[484566658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:948; }","duration":"228.07675ms","start":"2026-02-22T17:51:06.577778Z","end":"2026-02-22T17:51:06.805855Z","steps":["trace[484566658] 'range keys from in-memory index tree'  (duration: 227.603447ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:06.946991Z","caller":"traceutil/trace.go:171","msg":"trace[1138879505] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"156.678825ms","start":"2026-02-22T17:51:06.790048Z","end":"2026-02-22T17:51:06.946727Z","steps":["trace[1138879505] 'process raft request'  (duration: 156.443688ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:07.163601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.102775ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429714 > lease_revoke:<id:30c49c8678001dbe>","response":"size:29"}
{"level":"info","ts":"2026-02-22T17:51:07.164071Z","caller":"traceutil/trace.go:171","msg":"trace[730813795] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:985; }","duration":"357.241031ms","start":"2026-02-22T17:51:06.806794Z","end":"2026-02-22T17:51:07.164035Z","steps":["trace[730813795] 'read index received'  (duration: 139.662602ms)","trace[730813795] 'applied index is now lower than readState.Index'  (duration: 217.577509ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:07.164186Z","caller":"traceutil/trace.go:171","msg":"trace[755737283] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"354.274788ms","start":"2026-02-22T17:51:06.809888Z","end":"2026-02-22T17:51:07.164163Z","steps":["trace[755737283] 'process raft request'  (duration: 354.063952ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:07.16419Z","caller":"traceutil/trace.go:171","msg":"trace[434436730] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"354.317259ms","start":"2026-02-22T17:51:06.809843Z","end":"2026-02-22T17:51:07.16416Z","steps":["trace[434436730] 'process raft request'  (duration: 354.053002ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:07.164232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.432216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:07.164264Z","caller":"traceutil/trace.go:171","msg":"trace[1503559644] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"353.813556ms","start":"2026-02-22T17:51:06.810434Z","end":"2026-02-22T17:51:07.164247Z","steps":["trace[1503559644] 'process raft request'  (duration: 353.560039ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:07.164281Z","caller":"traceutil/trace.go:171","msg":"trace[1119981170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"357.524338ms","start":"2026-02-22T17:51:06.806741Z","end":"2026-02-22T17:51:07.164265Z","steps":["trace[1119981170] 'agreement among raft nodes before linearized reading'  (duration: 357.381304ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:07.164326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:06.806724Z","time spent":"357.590841ms","remote":"127.0.0.1:56858","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-02-22T17:51:07.164329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:06.809882Z","time spent":"354.35648ms","remote":"127.0.0.1:57114","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:941 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:07.164329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:06.809837Z","time spent":"354.413742ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:939 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:07.164368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:06.810427Z","time spent":"353.876967ms","remote":"127.0.0.1:57114","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:937 > 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-02-22T17:51:07.164487Z","caller":"traceutil/trace.go:171","msg":"trace[1697271437] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"354.819533ms","start":"2026-02-22T17:51:06.809656Z","end":"2026-02-22T17:51:07.164475Z","steps":["trace[1697271437] 'process raft request'  (duration: 354.051792ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:07.164552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:06.809636Z","time spent":"354.892796ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:938 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-22T17:51:10.963114Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12737477747463429755,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-22T17:51:11.510805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.408817ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477747463429756 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-22T17:51:11.510931Z","caller":"traceutil/trace.go:171","msg":"trace[1881107688] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"1.048342081s","start":"2026-02-22T17:51:10.46257Z","end":"2026-02-22T17:51:11.510912Z","steps":["trace[1881107688] 'read index received'  (duration: 523.820731ms)","trace[1881107688] 'applied index is now lower than readState.Index'  (duration: 524.51964ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:11.511146Z","caller":"traceutil/trace.go:171","msg":"trace[1686868795] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"1.078845909s","start":"2026-02-22T17:51:10.432286Z","end":"2026-02-22T17:51:11.511132Z","steps":["trace[1686868795] 'process raft request'  (duration: 554.041471ms)","trace[1686868795] 'compare'  (duration: 524.15089ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:51:11.511234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:10.432266Z","time spent":"1.078940151s","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<>"}
{"level":"warn","ts":"2026-02-22T17:51:11.511549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048980458s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-22T17:51:11.511589Z","caller":"traceutil/trace.go:171","msg":"trace[492186394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:971; }","duration":"1.049064421s","start":"2026-02-22T17:51:10.462515Z","end":"2026-02-22T17:51:11.511579Z","steps":["trace[492186394] 'agreement among raft nodes before linearized reading'  (duration: 1.048881856s)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.511618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:10.462494Z","time spent":"1.049118433s","remote":"127.0.0.1:57114","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-02-22T17:51:11.511746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.032796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-22T17:51:11.511819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.554072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-22T17:51:11.511853Z","caller":"traceutil/trace.go:171","msg":"trace[289689711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:971; }","duration":"333.624004ms","start":"2026-02-22T17:51:11.17822Z","end":"2026-02-22T17:51:11.511844Z","steps":["trace[289689711] 'agreement among raft nodes before linearized reading'  (duration: 333.538652ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.511879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:11.178198Z","time spent":"333.675835ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-22T17:51:11.51205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.328676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-22T17:51:11.512084Z","caller":"traceutil/trace.go:171","msg":"trace[176650148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:971; }","duration":"333.380446ms","start":"2026-02-22T17:51:11.178695Z","end":"2026-02-22T17:51:11.512075Z","steps":["trace[176650148] 'agreement among raft nodes before linearized reading'  (duration: 333.299704ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.512109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:11.178684Z","time spent":"333.419688ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-22T17:51:11.512136Z","caller":"traceutil/trace.go:171","msg":"trace[252316894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"942.1599ms","start":"2026-02-22T17:51:10.569637Z","end":"2026-02-22T17:51:11.511797Z","steps":["trace[252316894] 'agreement among raft nodes before linearized reading'  (duration: 941.974905ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.512202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.061076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-02-22T17:51:11.512186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:10.569614Z","time spent":"942.56204ms","remote":"127.0.0.1:56858","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-02-22T17:51:11.512257Z","caller":"traceutil/trace.go:171","msg":"trace[1115308908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"334.140108ms","start":"2026-02-22T17:51:11.178103Z","end":"2026-02-22T17:51:11.512243Z","steps":["trace[1115308908] 'agreement among raft nodes before linearized reading'  (duration: 333.958133ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.512298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:11.178091Z","time spent":"334.198799ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-22T17:51:11.512314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.148674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-22T17:51:11.512392Z","caller":"traceutil/trace.go:171","msg":"trace[1085534530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"336.275078ms","start":"2026-02-22T17:51:11.176099Z","end":"2026-02-22T17:51:11.512374Z","steps":["trace[1085534530] 'agreement among raft nodes before linearized reading'  (duration: 336.00015ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.512432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:11.176078Z","time spent":"336.346469ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-22T17:51:11.736841Z","caller":"traceutil/trace.go:171","msg":"trace[1895131903] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"220.182411ms","start":"2026-02-22T17:51:11.516636Z","end":"2026-02-22T17:51:11.736818Z","steps":["trace[1895131903] 'process raft request'  (duration: 124.139821ms)","trace[1895131903] 'compare'  (duration: 95.934487ms)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:51:11.737931Z","caller":"traceutil/trace.go:171","msg":"trace[238037353] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"221.188339ms","start":"2026-02-22T17:51:11.516677Z","end":"2026-02-22T17:51:11.737865Z","steps":["trace[238037353] 'process raft request'  (duration: 220.759737ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:11.738067Z","caller":"traceutil/trace.go:171","msg":"trace[964622295] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"221.053025ms","start":"2026-02-22T17:51:11.516984Z","end":"2026-02-22T17:51:11.738037Z","steps":["trace[964622295] 'process raft request'  (duration: 220.669194ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:11.738241Z","caller":"traceutil/trace.go:171","msg":"trace[2044444075] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"220.795037ms","start":"2026-02-22T17:51:11.517433Z","end":"2026-02-22T17:51:11.738228Z","steps":["trace[2044444075] 'process raft request'  (duration: 220.334754ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:11.738577Z","caller":"traceutil/trace.go:171","msg":"trace[68055500] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"221.023754ms","start":"2026-02-22T17:51:11.517542Z","end":"2026-02-22T17:51:11.738565Z","steps":["trace[68055500] 'process raft request'  (duration: 220.295613ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:11.738852Z","caller":"traceutil/trace.go:171","msg":"trace[1137369446] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"219.236794ms","start":"2026-02-22T17:51:11.519606Z","end":"2026-02-22T17:51:11.738843Z","steps":["trace[1137369446] 'process raft request'  (duration: 218.679789ms)"],"step_count":1}
{"level":"info","ts":"2026-02-22T17:51:11.738516Z","caller":"traceutil/trace.go:171","msg":"trace[223216418] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1009; }","duration":"220.406637ms","start":"2026-02-22T17:51:11.51809Z","end":"2026-02-22T17:51:11.738497Z","steps":["trace[223216418] 'read index received'  (duration: 122.636829ms)","trace[223216418] 'applied index is now lower than readState.Index'  (duration: 97.768898ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-22T17:51:11.739207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.104266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-02-22T17:51:11.739236Z","caller":"traceutil/trace.go:171","msg":"trace[937670919] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:977; }","duration":"221.183438ms","start":"2026-02-22T17:51:11.518044Z","end":"2026-02-22T17:51:11.739227Z","steps":["trace[937670919] 'agreement among raft nodes before linearized reading'  (duration: 221.052284ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.739229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.010878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-22T17:51:11.739269Z","caller":"traceutil/trace.go:171","msg":"trace[1991191448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"169.087481ms","start":"2026-02-22T17:51:11.570168Z","end":"2026-02-22T17:51:11.739255Z","steps":["trace[1991191448] 'agreement among raft nodes before linearized reading'  (duration: 169.018609ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:11.740554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.96162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.122\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-22T17:51:11.740607Z","caller":"traceutil/trace.go:171","msg":"trace[1865734263] range","detail":"{range_begin:/registry/masterleases/199.204.45.122; range_end:; response_count:1; response_revision:977; }","duration":"190.052093ms","start":"2026-02-22T17:51:11.550543Z","end":"2026-02-22T17:51:11.740595Z","steps":["trace[1865734263] 'agreement among raft nodes before linearized reading'  (duration: 188.602663ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:14.117704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.311452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-frlpj\" ","response":"range_response_count:1 size:12337"}
{"level":"info","ts":"2026-02-22T17:51:14.117882Z","caller":"traceutil/trace.go:171","msg":"trace[1375407274] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-frlpj; range_end:; response_count:1; response_revision:999; }","duration":"316.539009ms","start":"2026-02-22T17:51:13.801323Z","end":"2026-02-22T17:51:14.117862Z","steps":["trace[1375407274] 'range keys from in-memory index tree'  (duration: 316.155538ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:51:14.117995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T17:51:13.801307Z","time spent":"316.673013ms","remote":"127.0.0.1:57012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":12361,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-frlpj\" "}
{"level":"info","ts":"2026-02-22T17:54:12.820103Z","caller":"traceutil/trace.go:171","msg":"trace[1946407876] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1830; }","duration":"143.238958ms","start":"2026-02-22T17:54:12.676839Z","end":"2026-02-22T17:54:12.820078Z","steps":["trace[1946407876] 'read index received'  (duration: 143.056583ms)","trace[1946407876] 'applied index is now lower than readState.Index'  (duration: 181.355µs)"],"step_count":2}
{"level":"info","ts":"2026-02-22T17:54:12.820132Z","caller":"traceutil/trace.go:171","msg":"trace[644870865] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"144.633727ms","start":"2026-02-22T17:54:12.675465Z","end":"2026-02-22T17:54:12.820099Z","steps":["trace[644870865] 'process raft request'  (duration: 144.447742ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:54:12.820337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.474745ms","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-02-22T17:54:12.820399Z","caller":"traceutil/trace.go:171","msg":"trace[1634778839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1755; }","duration":"143.568808ms","start":"2026-02-22T17:54:12.676815Z","end":"2026-02-22T17:54:12.820384Z","steps":["trace[1634778839] 'agreement among raft nodes before linearized reading'  (duration: 143.349732ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-22T17:54:12.822436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.238649ms","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-02-22T17:54:12.822553Z","caller":"traceutil/trace.go:171","msg":"trace[29987517] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1755; }","duration":"139.408513ms","start":"2026-02-22T17:54:12.683117Z","end":"2026-02-22T17:54:12.822526Z","steps":["trace[29987517] 'agreement among raft nodes before linearized reading'  (duration: 137.367978ms)"],"step_count":1}