{"level":"warn","ts":"2026-02-05T11:16:12.952408Z","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-05T11:16:12.952551Z","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-05T11:16:12.952649Z","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-05T11:16:12.952678Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.122:2380"]}
{"level":"info","ts":"2026-02-05T11:16:12.952707Z","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-05T11:16:12.954436Z","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-05T11:16:12.954607Z","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":2,"max-cpu-available":2,"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-05T11:16:12.962444Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.779071ms"}
{"level":"info","ts":"2026-02-05T11:16:13.002117Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d2c3f297b56db0c4","cluster-id":"becafec23d27c587"}
{"level":"info","ts":"2026-02-05T11:16:13.002241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-05T11:16:13.002293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 0"}
{"level":"info","ts":"2026-02-05T11:16:13.002322Z","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-05T11:16:13.002342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 1"}
{"level":"info","ts":"2026-02-05T11:16:13.002427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"}
{"level":"warn","ts":"2026-02-05T11:16:13.022214Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-05T11:16:13.028965Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-05T11:16:13.033982Z","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-05T11:16:13.03805Z","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-05T11:16:13.038444Z","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-05T11:16:13.038591Z","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-05T11:16:13.038633Z","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-05T11:16:13.038662Z","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-05T11:16:13.040337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"}
{"level":"info","ts":"2026-02-05T11:16:13.041145Z","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-05T11:16:13.046705Z","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-05T11:16:13.046928Z","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-05T11:16:13.046954Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-05T11:16:13.047055Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.122:2380"}
{"level":"info","ts":"2026-02-05T11:16:13.047069Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.122:2380"}
{"level":"info","ts":"2026-02-05T11:16:13.103055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-05T11:16:13.103138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-05T11:16:13.103171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgPreVoteResp from d2c3f297b56db0c4 at term 1"}
{"level":"info","ts":"2026-02-05T11:16:13.103195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became candidate at term 2"}
{"level":"info","ts":"2026-02-05T11:16:13.10325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgVoteResp from d2c3f297b56db0c4 at term 2"}
{"level":"info","ts":"2026-02-05T11:16:13.103272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became leader at term 2"}
{"level":"info","ts":"2026-02-05T11:16:13.103304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d2c3f297b56db0c4 elected leader d2c3f297b56db0c4 at term 2"}
{"level":"info","ts":"2026-02-05T11:16:13.105341Z","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-05T11:16:13.105485Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-05T11:16:13.105855Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T11:16:13.106011Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-05T11:16:13.106272Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-05T11:16:13.106314Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-05T11:16:13.108513Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-05T11:16:13.112392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.122:2379"}
{"level":"info","ts":"2026-02-05T11:16:13.11267Z","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-05T11:16:13.112768Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T11:16:13.112789Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T11:16:22.618187Z","caller":"traceutil/trace.go:171","msg":"trace[682923111] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:351; }","duration":"107.684674ms","start":"2026-02-05T11:16:22.510488Z","end":"2026-02-05T11:16:22.618173Z","steps":["trace[682923111] 'read index received'  (duration: 107.537031ms)","trace[682923111] 'applied index is now lower than readState.Index'  (duration: 146.973µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:16:22.618651Z","caller":"traceutil/trace.go:171","msg":"trace[665144059] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"126.089276ms","start":"2026-02-05T11:16:22.492539Z","end":"2026-02-05T11:16:22.618628Z","steps":["trace[665144059] 'process raft request'  (duration: 125.542555ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:22.619383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.456219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-02-05T11:16:22.619542Z","caller":"traceutil/trace.go:171","msg":"trace[159867039] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:344; }","duration":"109.071272ms","start":"2026-02-05T11:16:22.510461Z","end":"2026-02-05T11:16:22.619532Z","steps":["trace[159867039] 'agreement among raft nodes before linearized reading'  (duration: 108.433468ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:16:44.310077Z","caller":"traceutil/trace.go:171","msg":"trace[1429606568] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"247.643848ms","start":"2026-02-05T11:16:44.062417Z","end":"2026-02-05T11:16:44.310061Z","steps":["trace[1429606568] 'process raft request'  (duration: 247.529956ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:16:45.60113Z","caller":"traceutil/trace.go:171","msg":"trace[1435916672] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"349.918379ms","start":"2026-02-05T11:16:45.251189Z","end":"2026-02-05T11:16:45.601107Z","steps":["trace[1435916672] 'process raft request'  (duration: 349.782936ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:45.601641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:16:45.251178Z","time spent":"350.01029ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:512 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-05T11:16:45.601949Z","caller":"traceutil/trace.go:171","msg":"trace[1122547880] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:530; }","duration":"307.25788ms","start":"2026-02-05T11:16:45.294684Z","end":"2026-02-05T11:16:45.601942Z","steps":["trace[1122547880] 'read index received'  (duration: 307.25293ms)","trace[1122547880] 'applied index is now lower than readState.Index'  (duration: 3.31µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:16:45.602006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.332641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-05T11:16:45.602022Z","caller":"traceutil/trace.go:171","msg":"trace[264504165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"307.382912ms","start":"2026-02-05T11:16:45.294633Z","end":"2026-02-05T11:16:45.602016Z","steps":["trace[264504165] 'agreement among raft nodes before linearized reading'  (duration: 307.345321ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:45.602036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:16:45.294616Z","time spent":"307.416373ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T11:16:45.603738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.34227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:16:45.603783Z","caller":"traceutil/trace.go:171","msg":"trace[2136551667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"281.412481ms","start":"2026-02-05T11:16:45.322358Z","end":"2026-02-05T11:16:45.603771Z","steps":["trace[2136551667] 'agreement among raft nodes before linearized reading'  (duration: 281.33104ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:45.603934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.480958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:16:45.603954Z","caller":"traceutil/trace.go:171","msg":"trace[1309209035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"179.523579ms","start":"2026-02-05T11:16:45.424424Z","end":"2026-02-05T11:16:45.603947Z","steps":["trace[1309209035] 'agreement among raft nodes before linearized reading'  (duration: 179.496028ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:51.90027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.409608ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418184325 > lease_revoke:<id:30c49c2d84544dea>","response":"size:29"}
{"level":"info","ts":"2026-02-05T11:16:51.900406Z","caller":"traceutil/trace.go:171","msg":"trace[1869148735] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:545; }","duration":"267.332379ms","start":"2026-02-05T11:16:51.633047Z","end":"2026-02-05T11:16:51.90038Z","steps":["trace[1869148735] 'read index received'  (duration: 134.687975ms)","trace[1869148735] 'applied index is now lower than readState.Index'  (duration: 132.642964ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:16:51.90141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.340469ms","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-05T11:16:51.901463Z","caller":"traceutil/trace.go:171","msg":"trace[1138455843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:531; }","duration":"268.469322ms","start":"2026-02-05T11:16:51.632981Z","end":"2026-02-05T11:16:51.90145Z","steps":["trace[1138455843] 'agreement among raft nodes before linearized reading'  (duration: 268.322139ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:51.902018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.487571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:16:51.902077Z","caller":"traceutil/trace.go:171","msg":"trace[1587147622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"255.559542ms","start":"2026-02-05T11:16:51.646506Z","end":"2026-02-05T11:16:51.902065Z","steps":["trace[1587147622] 'agreement among raft nodes before linearized reading'  (duration: 255.483081ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:51.902439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.786698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-05T11:16:51.902477Z","caller":"traceutil/trace.go:171","msg":"trace[1643274372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"256.845779ms","start":"2026-02-05T11:16:51.64562Z","end":"2026-02-05T11:16:51.902465Z","steps":["trace[1643274372] 'agreement among raft nodes before linearized reading'  (duration: 256.321848ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:16:53.358573Z","caller":"traceutil/trace.go:171","msg":"trace[800883056] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"917.635824ms","start":"2026-02-05T11:16:52.440913Z","end":"2026-02-05T11:16:53.358549Z","steps":["trace[800883056] 'process raft request'  (duration: 917.495831ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:53.35872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:16:52.440902Z","time spent":"917.743416ms","remote":"127.0.0.1:44716","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:531 > 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-05T11:16:53.704288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.190538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:16:53.704467Z","caller":"traceutil/trace.go:171","msg":"trace[866481523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"281.411613ms","start":"2026-02-05T11:16:53.423038Z","end":"2026-02-05T11:16:53.704449Z","steps":["trace[866481523] 'range keys from in-memory index tree'  (duration: 281.096036ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:56.420353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.221983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-05T11:16:56.420442Z","caller":"traceutil/trace.go:171","msg":"trace[1028660211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"493.364666ms","start":"2026-02-05T11:16:55.927058Z","end":"2026-02-05T11:16:56.420423Z","steps":["trace[1028660211] 'range keys from in-memory index tree'  (duration: 492.972918ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:56.420477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:16:55.927034Z","time spent":"493.435757ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T11:16:56.420673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.945637ms","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-05T11:16:56.420692Z","caller":"traceutil/trace.go:171","msg":"trace[262783602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"492.983258ms","start":"2026-02-05T11:16:55.927702Z","end":"2026-02-05T11:16:56.420686Z","steps":["trace[262783602] 'range keys from in-memory index tree'  (duration: 492.880386ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:56.420709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:16:55.927694Z","time spent":"493.010438ms","remote":"127.0.0.1:44716","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-05T11:16:56.420806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.768102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:16:56.420827Z","caller":"traceutil/trace.go:171","msg":"trace[715199891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:551; }","duration":"491.814784ms","start":"2026-02-05T11:16:55.929007Z","end":"2026-02-05T11:16:56.420822Z","steps":["trace[715199891] 'range keys from in-memory index tree'  (duration: 491.65296ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:16:56.420844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:16:55.928997Z","time spent":"491.843254ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-05T11:16:59.009977Z","caller":"traceutil/trace.go:171","msg":"trace[1288512708] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"135.506033ms","start":"2026-02-05T11:16:58.874436Z","end":"2026-02-05T11:16:59.009942Z","steps":["trace[1288512708] 'process raft request'  (duration: 135.325948ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:16:59.750005Z","caller":"traceutil/trace.go:171","msg":"trace[2099480044] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"183.270348ms","start":"2026-02-05T11:16:59.566694Z","end":"2026-02-05T11:16:59.749964Z","steps":["trace[2099480044] 'process raft request'  (duration: 103.419465ms)","trace[2099480044] 'compare'  (duration: 79.746051ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:16:59.794153Z","caller":"traceutil/trace.go:171","msg":"trace[1795319483] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"170.89965ms","start":"2026-02-05T11:16:59.623235Z","end":"2026-02-05T11:16:59.794134Z","steps":["trace[1795319483] 'process raft request'  (duration: 170.462881ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:07.585125Z","caller":"traceutil/trace.go:171","msg":"trace[1710820557] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"162.804967ms","start":"2026-02-05T11:17:07.422304Z","end":"2026-02-05T11:17:07.585109Z","steps":["trace[1710820557] 'read index received'  (duration: 162.690685ms)","trace[1710820557] 'applied index is now lower than readState.Index'  (duration: 113.672µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:07.585206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.895359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:07.585226Z","caller":"traceutil/trace.go:171","msg":"trace[1672211381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"162.949351ms","start":"2026-02-05T11:17:07.422271Z","end":"2026-02-05T11:17:07.58522Z","steps":["trace[1672211381] 'agreement among raft nodes before linearized reading'  (duration: 162.89889ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:07.58538Z","caller":"traceutil/trace.go:171","msg":"trace[1937851816] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"220.681496ms","start":"2026-02-05T11:17:07.364693Z","end":"2026-02-05T11:17:07.585374Z","steps":["trace[1937851816] 'process raft request'  (duration: 220.338359ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.100998Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12737477365418184702,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-05T11:17:15.202093Z","caller":"traceutil/trace.go:171","msg":"trace[1535905216] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"601.631093ms","start":"2026-02-05T11:17:14.600435Z","end":"2026-02-05T11:17:15.202066Z","steps":["trace[1535905216] 'read index received'  (duration: 601.446189ms)","trace[1535905216] 'applied index is now lower than readState.Index'  (duration: 183.894µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:15.202211Z","caller":"traceutil/trace.go:171","msg":"trace[1293559251] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"654.782277ms","start":"2026-02-05T11:17:14.547419Z","end":"2026-02-05T11:17:15.202201Z","steps":["trace[1293559251] 'process raft request'  (duration: 654.499371ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.202319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:14.547401Z","time spent":"654.836028ms","remote":"127.0.0.1:44716","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:723 > 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-05T11:17:15.202416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.500023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-05T11:17:15.202469Z","caller":"traceutil/trace.go:171","msg":"trace[1837676969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:728; }","duration":"569.592975ms","start":"2026-02-05T11:17:14.632862Z","end":"2026-02-05T11:17:15.202455Z","steps":["trace[1837676969] 'agreement among raft nodes before linearized reading'  (duration: 569.454602ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.202499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:14.632845Z","time spent":"569.648346ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T11:17:15.2026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.170914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:17:15.202616Z","caller":"traceutil/trace.go:171","msg":"trace[2050963778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:728; }","duration":"602.213875ms","start":"2026-02-05T11:17:14.600397Z","end":"2026-02-05T11:17:15.202611Z","steps":["trace[2050963778] 'agreement among raft nodes before linearized reading'  (duration: 602.167064ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.202634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:14.600382Z","time spent":"602.246346ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-05T11:17:15.994309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.62558ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418184706 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:724 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:17:15.994385Z","caller":"traceutil/trace.go:171","msg":"trace[814871076] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"786.936086ms","start":"2026-02-05T11:17:15.207434Z","end":"2026-02-05T11:17:15.99437Z","steps":["trace[814871076] 'process raft request'  (duration: 654.184783ms)","trace[814871076] 'compare'  (duration: 132.212451ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:15.994422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:15.207417Z","time spent":"786.987566ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:724 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-05T11:17:15.994783Z","caller":"traceutil/trace.go:171","msg":"trace[936965204] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:748; }","duration":"571.230111ms","start":"2026-02-05T11:17:15.423546Z","end":"2026-02-05T11:17:15.994776Z","steps":["trace[936965204] 'read index received'  (duration: 438.081238ms)","trace[936965204] 'applied index is now lower than readState.Index'  (duration: 133.148363ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:15.994905Z","caller":"traceutil/trace.go:171","msg":"trace[1934992745] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"786.21804ms","start":"2026-02-05T11:17:15.20868Z","end":"2026-02-05T11:17:15.994898Z","steps":["trace[1934992745] 'process raft request'  (duration: 786.054657ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.994939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:15.208658Z","time spent":"786.261562ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:725 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:15.99502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.473956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:15.995037Z","caller":"traceutil/trace.go:171","msg":"trace[1973453098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:730; }","duration":"571.519327ms","start":"2026-02-05T11:17:15.423512Z","end":"2026-02-05T11:17:15.995031Z","steps":["trace[1973453098] 'agreement among raft nodes before linearized reading'  (duration: 571.492426ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.995054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:15.423498Z","time spent":"571.552927ms","remote":"127.0.0.1:44408","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-05T11:17:15.995187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.18403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:17:15.995204Z","caller":"traceutil/trace.go:171","msg":"trace[1559713289] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:730; }","duration":"385.227672ms","start":"2026-02-05T11:17:15.609971Z","end":"2026-02-05T11:17:15.995199Z","steps":["trace[1559713289] 'agreement among raft nodes before linearized reading'  (duration: 385.16224ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.995227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:15.609956Z","time spent":"385.259262ms","remote":"127.0.0.1:44716","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-05T11:17:15.995345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.673914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:17:15.995361Z","caller":"traceutil/trace.go:171","msg":"trace[1362255596] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:730; }","duration":"229.707435ms","start":"2026-02-05T11:17:15.765649Z","end":"2026-02-05T11:17:15.995357Z","steps":["trace[1362255596] 'agreement among raft nodes before linearized reading'  (duration: 229.678444ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:15.995454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.042523ms","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-05T11:17:15.995469Z","caller":"traceutil/trace.go:171","msg":"trace[1369847229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:730; }","duration":"235.089124ms","start":"2026-02-05T11:17:15.760375Z","end":"2026-02-05T11:17:15.995464Z","steps":["trace[1369847229] 'agreement among raft nodes before linearized reading'  (duration: 235.045174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:17.056184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.176436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418184712 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:726 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:17:17.056353Z","caller":"traceutil/trace.go:171","msg":"trace[1495418451] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:751; }","duration":"567.786265ms","start":"2026-02-05T11:17:16.488537Z","end":"2026-02-05T11:17:17.056323Z","steps":["trace[1495418451] 'read index received'  (duration: 31.541µs)","trace[1495418451] 'applied index is now lower than readState.Index'  (duration: 567.753884ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:17.056471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.931808ms","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-05T11:17:17.056488Z","caller":"traceutil/trace.go:171","msg":"trace[813448083] range","detail":"{range_begin:/registry/masterleases/199.204.45.122; range_end:; response_count:1; response_revision:733; }","duration":"567.983279ms","start":"2026-02-05T11:17:16.488499Z","end":"2026-02-05T11:17:17.056483Z","steps":["trace[813448083] 'agreement among raft nodes before linearized reading'  (duration: 567.888587ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:17.056508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:16.488482Z","time spent":"568.02176ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.122\" "}
{"level":"info","ts":"2026-02-05T11:17:17.056707Z","caller":"traceutil/trace.go:171","msg":"trace[2031667509] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"1.054323934s","start":"2026-02-05T11:17:16.002375Z","end":"2026-02-05T11:17:17.056699Z","steps":["trace[2031667509] 'process raft request'  (duration: 149.541354ms)","trace[2031667509] 'compare'  (duration: 903.668455ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:17.056744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:16.002359Z","time spent":"1.054364805s","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:726 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-05T11:17:17.056824Z","caller":"traceutil/trace.go:171","msg":"trace[654234619] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"921.113831ms","start":"2026-02-05T11:17:16.135705Z","end":"2026-02-05T11:17:17.056819Z","steps":["trace[654234619] 'process raft request'  (duration: 920.555048ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:17.056857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:16.135678Z","time spent":"921.159282ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:662 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:17.616517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.558186ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418184717 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.122\" mod_revision:667 > success:<request_put:<key:\"/registry/masterleases/199.204.45.122\" value_size:67 lease:3514105328563408907 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.122\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:17:17.616612Z","caller":"traceutil/trace.go:171","msg":"trace[2024885921] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:754; }","duration":"408.075496ms","start":"2026-02-05T11:17:17.208522Z","end":"2026-02-05T11:17:17.616597Z","steps":["trace[2024885921] 'read index received'  (duration: 23.280754ms)","trace[2024885921] 'applied index is now lower than readState.Index'  (duration: 384.793542ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:17.616686Z","caller":"traceutil/trace.go:171","msg":"trace[549561885] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"500.59303ms","start":"2026-02-05T11:17:17.116083Z","end":"2026-02-05T11:17:17.616676Z","steps":["trace[549561885] 'process raft request'  (duration: 115.813918ms)","trace[549561885] 'compare'  (duration: 384.465534ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:17.616738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:17.116067Z","time spent":"500.642861ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.122\" mod_revision:667 > success:<request_put:<key:\"/registry/masterleases/199.204.45.122\" value_size:67 lease:3514105328563408907 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.122\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:17.617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.478205ms","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-05T11:17:17.617028Z","caller":"traceutil/trace.go:171","msg":"trace[75262328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:734; }","duration":"408.556746ms","start":"2026-02-05T11:17:17.208463Z","end":"2026-02-05T11:17:17.617019Z","steps":["trace[75262328] 'agreement among raft nodes before linearized reading'  (duration: 408.429453ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:17.617056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:17.208437Z","time spent":"408.612918ms","remote":"127.0.0.1:44716","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-05T11:17:17.617234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.130723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:17.617262Z","caller":"traceutil/trace.go:171","msg":"trace[908159539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:734; }","duration":"186.186804ms","start":"2026-02-05T11:17:17.431066Z","end":"2026-02-05T11:17:17.617253Z","steps":["trace[908159539] 'agreement among raft nodes before linearized reading'  (duration: 186.146373ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:18.008901Z","caller":"traceutil/trace.go:171","msg":"trace[2002573581] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"383.743828ms","start":"2026-02-05T11:17:17.625136Z","end":"2026-02-05T11:17:18.00888Z","steps":["trace[2002573581] 'process raft request'  (duration: 383.309567ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:18.009014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:17.625125Z","time spent":"383.83453ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:728 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-05T11:17:33.297179Z","caller":"traceutil/trace.go:171","msg":"trace[2007218629] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"175.035507ms","start":"2026-02-05T11:17:33.1221Z","end":"2026-02-05T11:17:33.297135Z","steps":["trace[2007218629] 'read index received'  (duration: 174.895514ms)","trace[2007218629] 'applied index is now lower than readState.Index'  (duration: 139.483µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:33.297277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.156389ms","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-05T11:17:33.297299Z","caller":"traceutil/trace.go:171","msg":"trace[1872548382] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:784; }","duration":"175.20843ms","start":"2026-02-05T11:17:33.122085Z","end":"2026-02-05T11:17:33.297293Z","steps":["trace[1872548382] 'agreement among raft nodes before linearized reading'  (duration: 175.145739ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:33.297369Z","caller":"traceutil/trace.go:171","msg":"trace[757249880] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"175.741763ms","start":"2026-02-05T11:17:33.12162Z","end":"2026-02-05T11:17:33.297362Z","steps":["trace[757249880] 'process raft request'  (duration: 175.393005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:34.311167Z","caller":"traceutil/trace.go:171","msg":"trace[450320752] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"182.659976ms","start":"2026-02-05T11:17:34.128491Z","end":"2026-02-05T11:17:34.311151Z","steps":["trace[450320752] 'process raft request'  (duration: 182.548373ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:34.639832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.64454ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418184872 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:781 > 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-05T11:17:34.639928Z","caller":"traceutil/trace.go:171","msg":"trace[486786695] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"483.38614ms","start":"2026-02-05T11:17:34.156512Z","end":"2026-02-05T11:17:34.639898Z","steps":["trace[486786695] 'read index received'  (duration: 154.671237ms)","trace[486786695] 'applied index is now lower than readState.Index'  (duration: 328.713823ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:34.640129Z","caller":"traceutil/trace.go:171","msg":"trace[1306172638] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"510.709313ms","start":"2026-02-05T11:17:34.129405Z","end":"2026-02-05T11:17:34.640115Z","steps":["trace[1306172638] 'process raft request'  (duration: 196.715796ms)","trace[1306172638] 'compare'  (duration: 313.385534ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:34.64021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:34.12939Z","time spent":"510.790565ms","remote":"127.0.0.1:44716","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:781 > 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-05T11:17:34.6404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.89479ms","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-05T11:17:34.640425Z","caller":"traceutil/trace.go:171","msg":"trace[370741710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:787; }","duration":"483.919952ms","start":"2026-02-05T11:17:34.156499Z","end":"2026-02-05T11:17:34.640419Z","steps":["trace[370741710] 'agreement among raft nodes before linearized reading'  (duration: 483.838659ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:34.64045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:34.156423Z","time spent":"484.023064ms","remote":"127.0.0.1:44716","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-05T11:17:34.640546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.142753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:34.640568Z","caller":"traceutil/trace.go:171","msg":"trace[1858491807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:787; }","duration":"215.199865ms","start":"2026-02-05T11:17:34.425363Z","end":"2026-02-05T11:17:34.640563Z","steps":["trace[1858491807] 'agreement among raft nodes before linearized reading'  (duration: 215.166424ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.193703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.986271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:17:36.193751Z","caller":"traceutil/trace.go:171","msg":"trace[1018458744] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:789; }","duration":"259.079114ms","start":"2026-02-05T11:17:35.934662Z","end":"2026-02-05T11:17:36.193741Z","steps":["trace[1018458744] 'count revisions from in-memory index tree'  (duration: 258.92363ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.193846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.001336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:17:36.193928Z","caller":"traceutil/trace.go:171","msg":"trace[1470062339] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:789; }","duration":"753.128818ms","start":"2026-02-05T11:17:35.440782Z","end":"2026-02-05T11:17:36.193911Z","steps":["trace[1470062339] 'count revisions from in-memory index tree'  (duration: 752.885533ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.193971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:35.440763Z","time spent":"753.19856ms","remote":"127.0.0.1:44914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T11:17:36.751184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.178484ms","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-05T11:17:36.751229Z","caller":"traceutil/trace.go:171","msg":"trace[2056029148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:790; }","duration":"435.265836ms","start":"2026-02-05T11:17:36.315953Z","end":"2026-02-05T11:17:36.751219Z","steps":["trace[2056029148] 'range keys from in-memory index tree'  (duration: 435.076892ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.751246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.315935Z","time spent":"435.307277ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T11:17:36.75167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.243643ms","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-05T11:17:36.751693Z","caller":"traceutil/trace.go:171","msg":"trace[535784926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"104.294845ms","start":"2026-02-05T11:17:36.647393Z","end":"2026-02-05T11:17:36.751688Z","steps":["trace[535784926] 'range keys from in-memory index tree'  (duration: 104.148661ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.751662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.776216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:17:36.751901Z","caller":"traceutil/trace.go:171","msg":"trace[1674818664] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:790; }","duration":"177.033982ms","start":"2026-02-05T11:17:36.574803Z","end":"2026-02-05T11:17:36.751837Z","steps":["trace[1674818664] 'count revisions from in-memory index tree'  (duration: 176.690094ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.752602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.196648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:36.752683Z","caller":"traceutil/trace.go:171","msg":"trace[1808946182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"327.435505ms","start":"2026-02-05T11:17:36.425235Z","end":"2026-02-05T11:17:36.752671Z","steps":["trace[1808946182] 'range keys from in-memory index tree'  (duration: 327.056445ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:36.752773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.425218Z","time spent":"327.543137ms","remote":"127.0.0.1:44408","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-05T11:17:36.758882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.427343ms","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-05T11:17:36.75892Z","caller":"traceutil/trace.go:171","msg":"trace[2132190699] range","detail":"{range_begin:/registry/masterleases/199.204.45.122; range_end:; response_count:1; response_revision:790; }","duration":"269.490095ms","start":"2026-02-05T11:17:36.489421Z","end":"2026-02-05T11:17:36.758911Z","steps":["trace[2132190699] 'range keys from in-memory index tree'  (duration: 269.341221ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:37.064544Z","caller":"traceutil/trace.go:171","msg":"trace[1187809679] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"301.210185ms","start":"2026-02-05T11:17:36.763308Z","end":"2026-02-05T11:17:37.064519Z","steps":["trace[1187809679] 'process raft request'  (duration: 301.082123ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:37.069067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.763289Z","time spent":"305.696144ms","remote":"127.0.0.1:44716","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:788 > 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-05T11:17:37.235951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.765476Z","time spent":"470.462855ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-05T11:17:37.236053Z","caller":"traceutil/trace.go:171","msg":"trace[983583511] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"470.471784ms","start":"2026-02-05T11:17:36.765542Z","end":"2026-02-05T11:17:37.236014Z","steps":["trace[983583511] 'read index received'  (duration: 303.958216ms)","trace[983583511] 'applied index is now lower than readState.Index'  (duration: 166.512728ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:37.236416Z","caller":"traceutil/trace.go:171","msg":"trace[908247625] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"468.723106ms","start":"2026-02-05T11:17:36.767676Z","end":"2026-02-05T11:17:37.236399Z","steps":["trace[908247625] 'process raft request'  (duration: 468.178404ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:37.236523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.767669Z","time spent":"468.796757ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:786 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:37.236781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.21453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:37.236835Z","caller":"traceutil/trace.go:171","msg":"trace[748613268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"471.302713ms","start":"2026-02-05T11:17:36.76552Z","end":"2026-02-05T11:17:37.236823Z","steps":["trace[748613268] 'agreement among raft nodes before linearized reading'  (duration: 470.597277ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:37.236875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.765505Z","time spent":"471.361824ms","remote":"127.0.0.1:44412","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-05T11:17:37.237151Z","caller":"traceutil/trace.go:171","msg":"trace[993094532] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"468.794847ms","start":"2026-02-05T11:17:36.768345Z","end":"2026-02-05T11:17:37.23714Z","steps":["trace[993094532] 'process raft request'  (duration: 467.631881ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:37.237241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:36.768339Z","time spent":"468.846239ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:787 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:49.707528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.96275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:17:49.707657Z","caller":"traceutil/trace.go:171","msg":"trace[1699468462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:879; }","duration":"411.095863ms","start":"2026-02-05T11:17:49.296512Z","end":"2026-02-05T11:17:49.707608Z","steps":["trace[1699468462] 'range keys from in-memory index tree'  (duration: 410.832428ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:49.707705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:49.296488Z","time spent":"411.195626ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-05T11:17:49.707735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.446876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-05T11:17:49.707787Z","caller":"traceutil/trace.go:171","msg":"trace[686549671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:879; }","duration":"399.565219ms","start":"2026-02-05T11:17:49.308207Z","end":"2026-02-05T11:17:49.707773Z","steps":["trace[686549671] 'range keys from in-memory index tree'  (duration: 399.302183ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:49.707809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:49.308187Z","time spent":"399.617119ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T11:17:49.707938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.737498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:17:49.707951Z","caller":"traceutil/trace.go:171","msg":"trace[920846740] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:879; }","duration":"302.80512ms","start":"2026-02-05T11:17:49.405141Z","end":"2026-02-05T11:17:49.707946Z","steps":["trace[920846740] 'range keys from in-memory index tree'  (duration: 302.627076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:49.707965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:49.405123Z","time spent":"302.836551ms","remote":"127.0.0.1:44716","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-05T11:17:49.707995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.245808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:17:49.708036Z","caller":"traceutil/trace.go:171","msg":"trace[814736647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:879; }","duration":"283.314829ms","start":"2026-02-05T11:17:49.424714Z","end":"2026-02-05T11:17:49.708029Z","steps":["trace[814736647] 'range keys from in-memory index tree'  (duration: 283.199197ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:52.196917Z","caller":"traceutil/trace.go:171","msg":"trace[657636800] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:915; }","duration":"473.46175ms","start":"2026-02-05T11:17:51.723432Z","end":"2026-02-05T11:17:52.196894Z","steps":["trace[657636800] 'read index received'  (duration: 473.383068ms)","trace[657636800] 'applied index is now lower than readState.Index'  (duration: 77.682µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:52.197164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.712715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:17:52.197233Z","caller":"traceutil/trace.go:171","msg":"trace[49549860] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:886; }","duration":"473.829308ms","start":"2026-02-05T11:17:51.723394Z","end":"2026-02-05T11:17:52.197223Z","steps":["trace[49549860] 'agreement among raft nodes before linearized reading'  (duration: 473.609853ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:52.197239Z","caller":"traceutil/trace.go:171","msg":"trace[992627742] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"474.429692ms","start":"2026-02-05T11:17:51.722784Z","end":"2026-02-05T11:17:52.197214Z","steps":["trace[992627742] 'process raft request'  (duration: 473.87733ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:52.197271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:51.723376Z","time spent":"473.885279ms","remote":"127.0.0.1:44716","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-05T11:17:52.197369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:51.722775Z","time spent":"474.522435ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:880 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:53.226234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.928044ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418185108 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:881 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:17:53.226292Z","caller":"traceutil/trace.go:171","msg":"trace[445919660] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"1.501197556s","start":"2026-02-05T11:17:51.725084Z","end":"2026-02-05T11:17:53.226281Z","steps":["trace[445919660] 'process raft request'  (duration: 715.17769ms)","trace[445919660] 'compare'  (duration: 785.480954ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:53.22632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:51.725076Z","time spent":"1.501231878s","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:881 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-05T11:17:53.226647Z","caller":"traceutil/trace.go:171","msg":"trace[1597147776] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:916; }","duration":"901.308353ms","start":"2026-02-05T11:17:52.325333Z","end":"2026-02-05T11:17:53.226642Z","steps":["trace[1597147776] 'read index received'  (duration: 114.941139ms)","trace[1597147776] 'applied index is now lower than readState.Index'  (duration: 786.365354ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:53.226717Z","caller":"traceutil/trace.go:171","msg":"trace[153930040] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"1.023940671s","start":"2026-02-05T11:17:52.202772Z","end":"2026-02-05T11:17:53.226713Z","steps":["trace[153930040] 'process raft request'  (duration: 1.023840199s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:53.226743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:52.202752Z","time spent":"1.023975193s","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:882 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-05T11:17:53.226838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.518628ms","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-05T11:17:53.226851Z","caller":"traceutil/trace.go:171","msg":"trace[1989390569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:888; }","duration":"901.566698ms","start":"2026-02-05T11:17:52.32528Z","end":"2026-02-05T11:17:53.226846Z","steps":["trace[1989390569] 'agreement among raft nodes before linearized reading'  (duration: 901.512797ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:53.226876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:17:52.325262Z","time spent":"901.59885ms","remote":"127.0.0.1:44716","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-05T11:17:53.236894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.365441ms","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-05T11:17:53.236924Z","caller":"traceutil/trace.go:171","msg":"trace[1590848823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:888; }","duration":"106.414781ms","start":"2026-02-05T11:17:53.130497Z","end":"2026-02-05T11:17:53.236912Z","steps":["trace[1590848823] 'agreement among raft nodes before linearized reading'  (duration: 106.34516ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:54.377597Z","caller":"traceutil/trace.go:171","msg":"trace[1826108873] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:921; }","duration":"134.396999ms","start":"2026-02-05T11:17:54.243185Z","end":"2026-02-05T11:17:54.377582Z","steps":["trace[1826108873] 'read index received'  (duration: 134.275696ms)","trace[1826108873] 'applied index is now lower than readState.Index'  (duration: 120.803µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:17:54.377692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.489031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:17:54.377707Z","caller":"traceutil/trace.go:171","msg":"trace[1628482466] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:891; }","duration":"134.550893ms","start":"2026-02-05T11:17:54.243152Z","end":"2026-02-05T11:17:54.377703Z","steps":["trace[1628482466] 'agreement among raft nodes before linearized reading'  (duration: 134.485921ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:17:54.377823Z","caller":"traceutil/trace.go:171","msg":"trace[1204183299] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"173.724718ms","start":"2026-02-05T11:17:54.204093Z","end":"2026-02-05T11:17:54.377818Z","steps":["trace[1204183299] 'process raft request'  (duration: 173.411951ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:17:55.51661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.362468ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418185132 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:890 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:17:55.516706Z","caller":"traceutil/trace.go:171","msg":"trace[2023837608] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"216.203537ms","start":"2026-02-05T11:17:55.300486Z","end":"2026-02-05T11:17:55.516689Z","steps":["trace[2023837608] 'process raft request'  (duration: 81.676115ms)","trace[2023837608] 'compare'  (duration: 134.259356ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:17:55.521581Z","caller":"traceutil/trace.go:171","msg":"trace[1329820286] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"219.332305ms","start":"2026-02-05T11:17:55.302237Z","end":"2026-02-05T11:17:55.52157Z","steps":["trace[1329820286] 'process raft request'  (duration: 219.272614ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:02.62819Z","caller":"traceutil/trace.go:171","msg":"trace[631067875] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"138.844957ms","start":"2026-02-05T11:18:02.489329Z","end":"2026-02-05T11:18:02.628174Z","steps":["trace[631067875] 'process raft request'  (duration: 138.722255ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:03.820808Z","caller":"traceutil/trace.go:171","msg":"trace[1383288210] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"206.681427ms","start":"2026-02-05T11:18:03.614111Z","end":"2026-02-05T11:18:03.820793Z","steps":["trace[1383288210] 'process raft request'  (duration: 126.583456ms)","trace[1383288210] 'compare'  (duration: 79.051738ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:18:04.741345Z","caller":"traceutil/trace.go:171","msg":"trace[777059071] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"106.177665ms","start":"2026-02-05T11:18:04.635145Z","end":"2026-02-05T11:18:04.741323Z","steps":["trace[777059071] 'process raft request'  (duration: 106.046312ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:05.504589Z","caller":"traceutil/trace.go:171","msg":"trace[2104122684] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"147.488639ms","start":"2026-02-05T11:18:05.357078Z","end":"2026-02-05T11:18:05.504566Z","steps":["trace[2104122684] 'read index received'  (duration: 140.775291ms)","trace[2104122684] 'applied index is now lower than readState.Index'  (duration: 6.711988ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:18:05.506602Z","caller":"traceutil/trace.go:171","msg":"trace[1273291377] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"175.352284ms","start":"2026-02-05T11:18:05.33124Z","end":"2026-02-05T11:18:05.506592Z","steps":["trace[1273291377] 'process raft request'  (duration: 166.683993ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:05.507468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.272081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:18:05.507509Z","caller":"traceutil/trace.go:171","msg":"trace[1245616027] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:920; }","duration":"150.458314ms","start":"2026-02-05T11:18:05.357041Z","end":"2026-02-05T11:18:05.507499Z","steps":["trace[1245616027] 'agreement among raft nodes before linearized reading'  (duration: 149.968873ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:05.674734Z","caller":"traceutil/trace.go:171","msg":"trace[795922206] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"161.775455ms","start":"2026-02-05T11:18:05.512939Z","end":"2026-02-05T11:18:05.674715Z","steps":["trace[795922206] 'process raft request'  (duration: 90.722624ms)","trace[795922206] 'compare'  (duration: 70.857616ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:18:06.901716Z","caller":"traceutil/trace.go:171","msg":"trace[1571284361] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"140.213498ms","start":"2026-02-05T11:18:06.761484Z","end":"2026-02-05T11:18:06.901697Z","steps":["trace[1571284361] 'process raft request'  (duration: 140.049134ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:07.913464Z","caller":"traceutil/trace.go:171","msg":"trace[1255763488] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"393.699578ms","start":"2026-02-05T11:18:07.51975Z","end":"2026-02-05T11:18:07.91345Z","steps":["trace[1255763488] 'process raft request'  (duration: 393.619597ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:07.913564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:07.519741Z","time spent":"393.77252ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:920 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-05T11:18:07.913794Z","caller":"traceutil/trace.go:171","msg":"trace[2069333306] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:960; }","duration":"233.803255ms","start":"2026-02-05T11:18:07.679985Z","end":"2026-02-05T11:18:07.913788Z","steps":["trace[2069333306] 'read index received'  (duration: 233.800965ms)","trace[2069333306] 'applied index is now lower than readState.Index'  (duration: 1.89µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:07.913875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.888387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:18:07.913892Z","caller":"traceutil/trace.go:171","msg":"trace[245501517] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:926; }","duration":"233.927188ms","start":"2026-02-05T11:18:07.679959Z","end":"2026-02-05T11:18:07.913886Z","steps":["trace[245501517] 'agreement among raft nodes before linearized reading'  (duration: 233.858636ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:08.191793Z","caller":"traceutil/trace.go:171","msg":"trace[1523403118] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"272.4923ms","start":"2026-02-05T11:18:07.919284Z","end":"2026-02-05T11:18:08.191777Z","steps":["trace[1523403118] 'process raft request'  (duration: 272.429609ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:08.191985Z","caller":"traceutil/trace.go:171","msg":"trace[1341541019] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"340.683746ms","start":"2026-02-05T11:18:07.851294Z","end":"2026-02-05T11:18:08.191978Z","steps":["trace[1341541019] 'process raft request'  (duration: 294.204089ms)","trace[1341541019] 'compare'  (duration: 45.72593ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:08.192063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:07.851273Z","time spent":"340.727777ms","remote":"127.0.0.1:44716","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:902 > 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-05T11:18:08.192114Z","caller":"traceutil/trace.go:171","msg":"trace[892459315] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:960; }","duration":"278.301439ms","start":"2026-02-05T11:18:07.913806Z","end":"2026-02-05T11:18:08.192107Z","steps":["trace[892459315] 'read index received'  (duration: 231.70213ms)","trace[892459315] 'applied index is now lower than readState.Index'  (duration: 46.598749ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:08.192208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.413517ms","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-05T11:18:08.192227Z","caller":"traceutil/trace.go:171","msg":"trace[1251425208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:928; }","duration":"510.442147ms","start":"2026-02-05T11:18:07.681779Z","end":"2026-02-05T11:18:08.192221Z","steps":["trace[1251425208] 'agreement among raft nodes before linearized reading'  (duration: 510.348285ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:08.192244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:07.681775Z","time spent":"510.465257ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-05T11:18:08.192387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.828556ms","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-05T11:18:08.192404Z","caller":"traceutil/trace.go:171","msg":"trace[379771779] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:928; }","duration":"362.873117ms","start":"2026-02-05T11:18:07.829526Z","end":"2026-02-05T11:18:08.192399Z","steps":["trace[379771779] 'agreement among raft nodes before linearized reading'  (duration: 362.822636ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:08.192421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:07.829511Z","time spent":"362.906577ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-05T11:18:14.174563Z","caller":"traceutil/trace.go:171","msg":"trace[549950149] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"204.810536ms","start":"2026-02-05T11:18:13.969444Z","end":"2026-02-05T11:18:14.174255Z","steps":["trace[549950149] 'process raft request'  (duration: 204.627472ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:14.659513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.534437ms","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-05T11:18:14.659578Z","caller":"traceutil/trace.go:171","msg":"trace[1206201075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:963; }","duration":"383.64066ms","start":"2026-02-05T11:18:14.275915Z","end":"2026-02-05T11:18:14.659556Z","steps":["trace[1206201075] 'range keys from in-memory index tree'  (duration: 383.358143ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:14.659602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:14.275876Z","time spent":"383.720911ms","remote":"127.0.0.1:44716","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-05T11:18:14.659819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.447531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-02-05T11:18:14.659836Z","caller":"traceutil/trace.go:171","msg":"trace[1708069960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"439.494822ms","start":"2026-02-05T11:18:14.220337Z","end":"2026-02-05T11:18:14.659832Z","steps":["trace[1708069960] 'range keys from in-memory index tree'  (duration: 439.358818ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:14.659849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:14.220317Z","time spent":"439.528922ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-05T11:18:14.659992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.719247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:18:14.660007Z","caller":"traceutil/trace.go:171","msg":"trace[1733360931] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:963; }","duration":"428.770637ms","start":"2026-02-05T11:18:14.231232Z","end":"2026-02-05T11:18:14.660002Z","steps":["trace[1733360931] 'count revisions from in-memory index tree'  (duration: 428.319238ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:14.660033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:14.231218Z","time spent":"428.812119ms","remote":"127.0.0.1:44834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T11:18:14.660438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.800423ms","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-05T11:18:14.660454Z","caller":"traceutil/trace.go:171","msg":"trace[81146791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:963; }","duration":"376.834474ms","start":"2026-02-05T11:18:14.283615Z","end":"2026-02-05T11:18:14.660449Z","steps":["trace[81146791] 'range keys from in-memory index tree'  (duration: 376.726521ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:14.660466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:14.283608Z","time spent":"376.854754ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-05T11:18:14.826198Z","caller":"traceutil/trace.go:171","msg":"trace[1961434181] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"159.34256ms","start":"2026-02-05T11:18:14.666839Z","end":"2026-02-05T11:18:14.826182Z","steps":["trace[1961434181] 'process raft request'  (duration: 159.233356ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:14.827186Z","caller":"traceutil/trace.go:171","msg":"trace[950362775] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"152.997675ms","start":"2026-02-05T11:18:14.674161Z","end":"2026-02-05T11:18:14.827159Z","steps":["trace[950362775] 'process raft request'  (duration: 152.564776ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:14.827314Z","caller":"traceutil/trace.go:171","msg":"trace[1569566325] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"153.020776ms","start":"2026-02-05T11:18:14.674288Z","end":"2026-02-05T11:18:14.827308Z","steps":["trace[1569566325] 'process raft request'  (duration: 152.531705ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:22.522585Z","caller":"traceutil/trace.go:171","msg":"trace[1789171807] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1045; }","duration":"161.420288ms","start":"2026-02-05T11:18:22.361146Z","end":"2026-02-05T11:18:22.522567Z","steps":["trace[1789171807] 'read index received'  (duration: 161.254014ms)","trace[1789171807] 'applied index is now lower than readState.Index'  (duration: 165.604µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:18:22.522733Z","caller":"traceutil/trace.go:171","msg":"trace[93253004] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"293.251491ms","start":"2026-02-05T11:18:22.229474Z","end":"2026-02-05T11:18:22.522725Z","steps":["trace[93253004] 'process raft request'  (duration: 292.974555ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:22.523153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.98822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:18:22.523268Z","caller":"traceutil/trace.go:171","msg":"trace[224319787] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1009; }","duration":"162.130684ms","start":"2026-02-05T11:18:22.361108Z","end":"2026-02-05T11:18:22.523238Z","steps":["trace[224319787] 'agreement among raft nodes before linearized reading'  (duration: 162.002581ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:24.996393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.897204ms","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-05T11:18:24.996624Z","caller":"traceutil/trace.go:171","msg":"trace[1738072894] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1033; }","duration":"200.19172ms","start":"2026-02-05T11:18:24.796417Z","end":"2026-02-05T11:18:24.996608Z","steps":["trace[1738072894] 'range keys from in-memory index tree'  (duration: 199.764581ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:24.997301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.486509ms","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-05T11:18:24.997407Z","caller":"traceutil/trace.go:171","msg":"trace[1054755045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1033; }","duration":"118.631132ms","start":"2026-02-05T11:18:24.878767Z","end":"2026-02-05T11:18:24.997398Z","steps":["trace[1054755045] 'range keys from in-memory index tree'  (duration: 118.377986ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:24.998049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.976719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:18:24.999368Z","caller":"traceutil/trace.go:171","msg":"trace[570378691] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1033; }","duration":"116.312709ms","start":"2026-02-05T11:18:24.883045Z","end":"2026-02-05T11:18:24.999357Z","steps":["trace[570378691] 'range keys from in-memory index tree'  (duration: 114.885688ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:24.99853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.849454ms","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-05T11:18:24.999572Z","caller":"traceutil/trace.go:171","msg":"trace[1682907699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1033; }","duration":"110.996129ms","start":"2026-02-05T11:18:24.888539Z","end":"2026-02-05T11:18:24.999535Z","steps":["trace[1682907699] 'range keys from in-memory index tree'  (duration: 109.692359ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:33.168299Z","caller":"traceutil/trace.go:171","msg":"trace[143137839] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1107; }","duration":"140.236825ms","start":"2026-02-05T11:18:33.028043Z","end":"2026-02-05T11:18:33.16828Z","steps":["trace[143137839] 'read index received'  (duration: 140.228314ms)","trace[143137839] 'applied index is now lower than readState.Index'  (duration: 7.051µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:33.16841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.351438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:18:33.168082Z","caller":"traceutil/trace.go:171","msg":"trace[1344538859] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"249.207948ms","start":"2026-02-05T11:18:32.91885Z","end":"2026-02-05T11:18:33.168058Z","steps":["trace[1344538859] 'process raft request'  (duration: 249.080845ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:33.193005Z","caller":"traceutil/trace.go:171","msg":"trace[1663505] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1068; }","duration":"164.986779ms","start":"2026-02-05T11:18:33.027886Z","end":"2026-02-05T11:18:33.192873Z","steps":["trace[1663505] 'agreement among raft nodes before linearized reading'  (duration: 140.427739ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:33.380855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.517731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-05T11:18:33.380963Z","caller":"traceutil/trace.go:171","msg":"trace[1123701724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1068; }","duration":"255.697514ms","start":"2026-02-05T11:18:33.125237Z","end":"2026-02-05T11:18:33.380935Z","steps":["trace[1123701724] 'agreement among raft nodes before linearized reading'  (duration: 67.939767ms)","trace[1123701724] 'range keys from in-memory index tree'  (duration: 187.464931ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:33.381942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.502759ms","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-05T11:18:33.381973Z","caller":"traceutil/trace.go:171","msg":"trace[2120053624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1068; }","duration":"294.57669ms","start":"2026-02-05T11:18:33.087387Z","end":"2026-02-05T11:18:33.381964Z","steps":["trace[2120053624] 'agreement among raft nodes before linearized reading'  (duration: 105.700098ms)","trace[2120053624] 'range keys from in-memory index tree'  (duration: 188.74958ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:33.382212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.953193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-02-05T11:18:33.382272Z","caller":"traceutil/trace.go:171","msg":"trace[367263880] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1068; }","duration":"246.051285ms","start":"2026-02-05T11:18:33.136213Z","end":"2026-02-05T11:18:33.382264Z","steps":["trace[367263880] 'agreement among raft nodes before linearized reading'  (duration: 56.944338ms)","trace[367263880] 'range keys from in-memory index tree'  (duration: 188.998665ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:33.382497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.791015ms","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-05T11:18:33.382603Z","caller":"traceutil/trace.go:171","msg":"trace[1359660495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1068; }","duration":"247.915998ms","start":"2026-02-05T11:18:33.134679Z","end":"2026-02-05T11:18:33.382595Z","steps":["trace[1359660495] 'agreement among raft nodes before linearized reading'  (duration: 58.485653ms)","trace[1359660495] 'range keys from in-memory index tree'  (duration: 189.291742ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:33.382863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.398454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-02-05T11:18:33.382929Z","caller":"traceutil/trace.go:171","msg":"trace[109005412] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1068; }","duration":"257.478736ms","start":"2026-02-05T11:18:33.125439Z","end":"2026-02-05T11:18:33.382917Z","steps":["trace[109005412] 'agreement among raft nodes before linearized reading'  (duration: 67.732263ms)","trace[109005412] 'range keys from in-memory index tree'  (duration: 189.63931ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:33.381402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.295838ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:18:33.429571Z","caller":"traceutil/trace.go:171","msg":"trace[1250706894] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1068; }","duration":"221.946376ms","start":"2026-02-05T11:18:33.207594Z","end":"2026-02-05T11:18:33.42954Z","steps":["trace[1250706894] 'range keys from in-memory index tree'  (duration: 173.278398ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:33.798406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.747298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:18:33.79846Z","caller":"traceutil/trace.go:171","msg":"trace[842683999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"317.84934ms","start":"2026-02-05T11:18:33.480599Z","end":"2026-02-05T11:18:33.798448Z","steps":["trace[842683999] 'range keys from in-memory index tree'  (duration: 317.512683ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:33.798482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:18:33.480584Z","time spent":"317.892942ms","remote":"127.0.0.1:44412","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-05T11:18:37.785267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.98573ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418185570 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1078 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:18:37.785377Z","caller":"traceutil/trace.go:171","msg":"trace[1018683734] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"206.975385ms","start":"2026-02-05T11:18:37.578384Z","end":"2026-02-05T11:18:37.785359Z","steps":["trace[1018683734] 'process raft request'  (duration: 51.818821ms)","trace[1018683734] 'compare'  (duration: 154.851537ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:18:37.791197Z","caller":"traceutil/trace.go:171","msg":"trace[686373490] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"210.856492ms","start":"2026-02-05T11:18:37.58032Z","end":"2026-02-05T11:18:37.791177Z","steps":["trace[686373490] 'process raft request'  (duration: 210.723569ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:37.791367Z","caller":"traceutil/trace.go:171","msg":"trace[406827172] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"210.990445ms","start":"2026-02-05T11:18:37.580369Z","end":"2026-02-05T11:18:37.79136Z","steps":["trace[406827172] 'process raft request'  (duration: 210.777241ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:37.79189Z","caller":"traceutil/trace.go:171","msg":"trace[1812868289] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"192.090535ms","start":"2026-02-05T11:18:37.599559Z","end":"2026-02-05T11:18:37.79165Z","steps":["trace[1812868289] 'process raft request'  (duration: 191.773818ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:39.448699Z","caller":"traceutil/trace.go:171","msg":"trace[1627533424] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"273.030859ms","start":"2026-02-05T11:18:39.175638Z","end":"2026-02-05T11:18:39.448669Z","steps":["trace[1627533424] 'process raft request'  (duration: 272.655241ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:39.705086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.467733ms","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-05T11:18:39.705158Z","caller":"traceutil/trace.go:171","msg":"trace[782573645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1092; }","duration":"145.580916ms","start":"2026-02-05T11:18:39.55956Z","end":"2026-02-05T11:18:39.705141Z","steps":["trace[782573645] 'range keys from in-memory index tree'  (duration: 145.296299ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:39.707653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.280305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:18:39.707703Z","caller":"traceutil/trace.go:171","msg":"trace[97811445] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1092; }","duration":"194.377927ms","start":"2026-02-05T11:18:39.513313Z","end":"2026-02-05T11:18:39.707691Z","steps":["trace[97811445] 'count revisions from in-memory index tree'  (duration: 194.175423ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:39.949498Z","caller":"traceutil/trace.go:171","msg":"trace[1192843927] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"155.473562ms","start":"2026-02-05T11:18:39.794001Z","end":"2026-02-05T11:18:39.949474Z","steps":["trace[1192843927] 'process raft request'  (duration: 118.317395ms)","trace[1192843927] 'compare'  (duration: 36.911391ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:18:39.950236Z","caller":"traceutil/trace.go:171","msg":"trace[355534717] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"154.95463ms","start":"2026-02-05T11:18:39.795269Z","end":"2026-02-05T11:18:39.950223Z","steps":["trace[355534717] 'read index received'  (duration: 116.900152ms)","trace[355534717] 'applied index is now lower than readState.Index'  (duration: 38.050308ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:18:39.950767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.479231ms","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-05T11:18:39.950934Z","caller":"traceutil/trace.go:171","msg":"trace[485757985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1094; }","duration":"155.676525ms","start":"2026-02-05T11:18:39.795245Z","end":"2026-02-05T11:18:39.950921Z","steps":["trace[485757985] 'agreement among raft nodes before linearized reading'  (duration: 155.378539ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:39.951342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.343885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-02-05T11:18:39.951494Z","caller":"traceutil/trace.go:171","msg":"trace[1094020235] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1094; }","duration":"154.51639ms","start":"2026-02-05T11:18:39.796967Z","end":"2026-02-05T11:18:39.951483Z","steps":["trace[1094020235] 'agreement among raft nodes before linearized reading'  (duration: 154.276845ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:18:39.952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.210806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:18:39.95218Z","caller":"traceutil/trace.go:171","msg":"trace[1821210699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"148.3707ms","start":"2026-02-05T11:18:39.803766Z","end":"2026-02-05T11:18:39.952137Z","steps":["trace[1821210699] 'agreement among raft nodes before linearized reading'  (duration: 148.123654ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:18:40.169237Z","caller":"traceutil/trace.go:171","msg":"trace[1233530101] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"117.64187ms","start":"2026-02-05T11:18:40.05157Z","end":"2026-02-05T11:18:40.169212Z","steps":["trace[1233530101] 'process raft request'  (duration: 114.923288ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:19:58.833122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.711204ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418186433 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1411 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T11:19:58.833183Z","caller":"traceutil/trace.go:171","msg":"trace[1641573886] linearizableReadLoop","detail":"{readStateIndex:1475; appliedIndex:1474; }","duration":"122.898326ms","start":"2026-02-05T11:19:58.710275Z","end":"2026-02-05T11:19:58.833173Z","steps":["trace[1641573886] 'read index received'  (duration: 22.012518ms)","trace[1641573886] 'applied index is now lower than readState.Index'  (duration: 100.884848ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:19:58.833234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.958207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:19:58.833247Z","caller":"traceutil/trace.go:171","msg":"trace[614317602] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1419; }","duration":"122.999577ms","start":"2026-02-05T11:19:58.710242Z","end":"2026-02-05T11:19:58.833241Z","steps":["trace[614317602] 'agreement among raft nodes before linearized reading'  (duration: 122.957566ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:19:58.833397Z","caller":"traceutil/trace.go:171","msg":"trace[34550849] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"156.639174ms","start":"2026-02-05T11:19:58.676751Z","end":"2026-02-05T11:19:58.83339Z","steps":["trace[34550849] 'process raft request'  (duration: 55.602533ms)","trace[34550849] 'compare'  (duration: 100.592441ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:20:31.02295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.354526ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418186759 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1540 > 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-05T11:20:31.023025Z","caller":"traceutil/trace.go:171","msg":"trace[1753604745] linearizableReadLoop","detail":"{readStateIndex:1610; appliedIndex:1609; }","duration":"126.289246ms","start":"2026-02-05T11:20:30.896725Z","end":"2026-02-05T11:20:31.023014Z","steps":["trace[1753604745] 'read index received'  (duration: 18.798717ms)","trace[1753604745] 'applied index is now lower than readState.Index'  (duration: 107.489738ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:20:31.023124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.407778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-05T11:20:31.023138Z","caller":"traceutil/trace.go:171","msg":"trace[274426907] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1548; }","duration":"126.454319ms","start":"2026-02-05T11:20:30.896678Z","end":"2026-02-05T11:20:31.023132Z","steps":["trace[274426907] 'agreement among raft nodes before linearized reading'  (duration: 126.362487ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:20:31.023287Z","caller":"traceutil/trace.go:171","msg":"trace[224781011] transaction","detail":"{read_only:false; response_revision:1548; number_of_response:1; }","duration":"244.927188ms","start":"2026-02-05T11:20:30.778353Z","end":"2026-02-05T11:20:31.02328Z","steps":["trace[224781011] 'process raft request'  (duration: 137.186733ms)","trace[224781011] 'compare'  (duration: 107.281784ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:20:48.791394Z","caller":"traceutil/trace.go:171","msg":"trace[1207976403] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"142.020433ms","start":"2026-02-05T11:20:48.649336Z","end":"2026-02-05T11:20:48.791356Z","steps":["trace[1207976403] 'process raft request'  (duration: 129.989251ms)","trace[1207976403] 'compare'  (duration: 11.862979ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:20:58.95854Z","caller":"traceutil/trace.go:171","msg":"trace[1016058377] transaction","detail":"{read_only:false; response_revision:1661; number_of_response:1; }","duration":"128.816652ms","start":"2026-02-05T11:20:58.8297Z","end":"2026-02-05T11:20:58.958517Z","steps":["trace[1016058377] 'process raft request'  (duration: 128.68899ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:21:14.478719Z","caller":"traceutil/trace.go:171","msg":"trace[911545546] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"195.20043ms","start":"2026-02-05T11:21:14.281969Z","end":"2026-02-05T11:21:14.47717Z","steps":["trace[911545546] 'process raft request'  (duration: 194.7713ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:21:23.528839Z","caller":"traceutil/trace.go:171","msg":"trace[354687222] transaction","detail":"{read_only:false; response_revision:1763; number_of_response:1; }","duration":"110.311443ms","start":"2026-02-05T11:21:23.418504Z","end":"2026-02-05T11:21:23.528815Z","steps":["trace[354687222] 'process raft request'  (duration: 110.225431ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:21:23.529087Z","caller":"traceutil/trace.go:171","msg":"trace[1621953091] transaction","detail":"{read_only:false; response_revision:1762; number_of_response:1; }","duration":"114.299633ms","start":"2026-02-05T11:21:23.414767Z","end":"2026-02-05T11:21:23.529067Z","steps":["trace[1621953091] 'process raft request'  (duration: 42.057225ms)","trace[1621953091] 'compare'  (duration: 71.625304ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:21:28.919968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.597596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-02-05T11:21:28.920043Z","caller":"traceutil/trace.go:171","msg":"trace[2024034514] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1797; }","duration":"187.727479ms","start":"2026-02-05T11:21:28.732297Z","end":"2026-02-05T11:21:28.920025Z","steps":["trace[2024034514] 'range keys from in-memory index tree'  (duration: 187.366301ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:28.920297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.373646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:21:28.920336Z","caller":"traceutil/trace.go:171","msg":"trace[1177070804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1797; }","duration":"166.433307ms","start":"2026-02-05T11:21:28.75389Z","end":"2026-02-05T11:21:28.920324Z","steps":["trace[1177070804] 'range keys from in-memory index tree'  (duration: 166.320144ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:21:29.463729Z","caller":"traceutil/trace.go:171","msg":"trace[1281514749] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"130.852092ms","start":"2026-02-05T11:21:29.332844Z","end":"2026-02-05T11:21:29.463696Z","steps":["trace[1281514749] 'process raft request'  (duration: 56.272504ms)","trace[1281514749] 'compare'  (duration: 74.002765ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:21:29.465914Z","caller":"traceutil/trace.go:171","msg":"trace[195245134] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"123.857524ms","start":"2026-02-05T11:21:29.342038Z","end":"2026-02-05T11:21:29.465895Z","steps":["trace[195245134] 'process raft request'  (duration: 123.166858ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:29.708107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.447427ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418187431 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1793 > 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-05T11:21:29.709068Z","caller":"traceutil/trace.go:171","msg":"trace[991151521] linearizableReadLoop","detail":"{readStateIndex:1881; appliedIndex:1879; }","duration":"117.383156ms","start":"2026-02-05T11:21:29.591668Z","end":"2026-02-05T11:21:29.709051Z","steps":["trace[991151521] 'read index received'  (duration: 108.645078ms)","trace[991151521] 'applied index is now lower than readState.Index'  (duration: 8.737058ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:21:29.709097Z","caller":"traceutil/trace.go:171","msg":"trace[506777288] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"171.572003ms","start":"2026-02-05T11:21:29.5375Z","end":"2026-02-05T11:21:29.709072Z","steps":["trace[506777288] 'process raft request'  (duration: 46.067514ms)","trace[506777288] 'compare'  (duration: 124.356754ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:21:29.709266Z","caller":"traceutil/trace.go:171","msg":"trace[530533881] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"125.864558ms","start":"2026-02-05T11:21:29.583394Z","end":"2026-02-05T11:21:29.709259Z","steps":["trace[530533881] 'process raft request'  (duration: 125.585691ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:29.709337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.651983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/default/default\" ","response":"range_response_count:1 size:171"}
{"level":"info","ts":"2026-02-05T11:21:29.71086Z","caller":"traceutil/trace.go:171","msg":"trace[633961613] range","detail":"{range_begin:/registry/serviceaccounts/default/default; range_end:; response_count:1; response_revision:1806; }","duration":"119.204068ms","start":"2026-02-05T11:21:29.591646Z","end":"2026-02-05T11:21:29.71085Z","steps":["trace[633961613] 'agreement among raft nodes before linearized reading'  (duration: 117.644013ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:32.079105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.547878ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418187465 > lease_revoke:<id:30c49c2d845459f1>","response":"size:29"}
{"level":"info","ts":"2026-02-05T11:21:35.004309Z","caller":"traceutil/trace.go:171","msg":"trace[938940049] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"107.77913ms","start":"2026-02-05T11:21:34.896509Z","end":"2026-02-05T11:21:35.004288Z","steps":["trace[938940049] 'read index received'  (duration: 107.577885ms)","trace[938940049] 'applied index is now lower than readState.Index'  (duration: 200.385µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:21:35.004496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.966764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2723"}
{"level":"info","ts":"2026-02-05T11:21:35.004531Z","caller":"traceutil/trace.go:171","msg":"trace[479759586] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1829; }","duration":"108.064726ms","start":"2026-02-05T11:21:34.896457Z","end":"2026-02-05T11:21:35.004522Z","steps":["trace[479759586] 'agreement among raft nodes before linearized reading'  (duration: 107.911543ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:21:35.004715Z","caller":"traceutil/trace.go:171","msg":"trace[1898219188] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"153.985605ms","start":"2026-02-05T11:21:34.850719Z","end":"2026-02-05T11:21:35.004705Z","steps":["trace[1898219188] 'process raft request'  (duration: 153.420092ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:37.776038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.591676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-05T11:21:37.776134Z","caller":"traceutil/trace.go:171","msg":"trace[1393713385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1843; }","duration":"263.718358ms","start":"2026-02-05T11:21:37.512397Z","end":"2026-02-05T11:21:37.776116Z","steps":["trace[1393713385] 'range keys from in-memory index tree'  (duration: 263.446132ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:37.776377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.960235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T11:21:37.776438Z","caller":"traceutil/trace.go:171","msg":"trace[1177542288] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1843; }","duration":"276.053207ms","start":"2026-02-05T11:21:37.500368Z","end":"2026-02-05T11:21:37.776422Z","steps":["trace[1177542288] 'count revisions from in-memory index tree'  (duration: 275.915794ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:46.093525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.853559ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12737477365418187633 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1872 > 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-05T11:21:46.093623Z","caller":"traceutil/trace.go:171","msg":"trace[1493327307] linearizableReadLoop","detail":"{readStateIndex:1963; appliedIndex:1961; }","duration":"261.761214ms","start":"2026-02-05T11:21:45.831852Z","end":"2026-02-05T11:21:46.093614Z","steps":["trace[1493327307] 'read index received'  (duration: 55.784113ms)","trace[1493327307] 'applied index is now lower than readState.Index'  (duration: 205.976611ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:21:46.093732Z","caller":"traceutil/trace.go:171","msg":"trace[758748182] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"262.847939ms","start":"2026-02-05T11:21:45.830878Z","end":"2026-02-05T11:21:46.093726Z","steps":["trace[758748182] 'process raft request'  (duration: 56.746795ms)","trace[758748182] 'compare'  (duration: 205.751596ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:21:46.093819Z","caller":"traceutil/trace.go:171","msg":"trace[1247636089] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"262.03876ms","start":"2026-02-05T11:21:45.831776Z","end":"2026-02-05T11:21:46.093815Z","steps":["trace[1247636089] 'process raft request'  (duration: 261.808145ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:46.093945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.101771ms","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-05T11:21:46.09396Z","caller":"traceutil/trace.go:171","msg":"trace[77555273] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1885; }","duration":"262.137442ms","start":"2026-02-05T11:21:45.831818Z","end":"2026-02-05T11:21:46.093956Z","steps":["trace[77555273] 'agreement among raft nodes before linearized reading'  (duration: 262.04609ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:21:46.094055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.689499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-02-05T11:21:46.094069Z","caller":"traceutil/trace.go:171","msg":"trace[1620997698] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1885; }","duration":"199.73026ms","start":"2026-02-05T11:21:45.894335Z","end":"2026-02-05T11:21:46.094065Z","steps":["trace[1620997698] 'agreement among raft nodes before linearized reading'  (duration: 199.692189ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:21:47.357762Z","caller":"traceutil/trace.go:171","msg":"trace[4605026] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"691.691034ms","start":"2026-02-05T11:21:46.666054Z","end":"2026-02-05T11:21:47.357745Z","steps":["trace[4605026] 'process raft request'  (duration: 637.493818ms)","trace[4605026] 'compare'  (duration: 53.582483ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:21:47.357869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T11:21:46.666033Z","time spent":"691.777266ms","remote":"127.0.0.1:44446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.122\" mod_revision:1842 > success:<request_put:<key:\"/registry/masterleases/199.204.45.122\" value_size:67 lease:3514105328563411835 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.122\" > >"}
{"level":"info","ts":"2026-02-05T11:22:03.807895Z","caller":"traceutil/trace.go:171","msg":"trace[1257977526] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2043; }","duration":"117.08098ms","start":"2026-02-05T11:22:03.690791Z","end":"2026-02-05T11:22:03.807872Z","steps":["trace[1257977526] 'read index received'  (duration: 32.675639ms)","trace[1257977526] 'applied index is now lower than readState.Index'  (duration: 84.404161ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T11:22:03.808032Z","caller":"traceutil/trace.go:171","msg":"trace[1339399585] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"172.012003ms","start":"2026-02-05T11:22:03.635994Z","end":"2026-02-05T11:22:03.808006Z","steps":["trace[1339399585] 'process raft request'  (duration: 87.470569ms)","trace[1339399585] 'compare'  (duration: 84.298239ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:22:03.808077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.258814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:699"}
{"level":"info","ts":"2026-02-05T11:22:03.808117Z","caller":"traceutil/trace.go:171","msg":"trace[232187290] range","detail":"{range_begin:/registry/clusterroles/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:1962; }","duration":"117.338975ms","start":"2026-02-05T11:22:03.690765Z","end":"2026-02-05T11:22:03.808104Z","steps":["trace[232187290] 'agreement among raft nodes before linearized reading'  (duration: 117.246013ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:22:03.808403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.781767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" ","response":"range_response_count:1 size:715"}
{"level":"info","ts":"2026-02-05T11:22:03.80844Z","caller":"traceutil/trace.go:171","msg":"trace[268604594] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:1; response_revision:1962; }","duration":"110.845249ms","start":"2026-02-05T11:22:03.697585Z","end":"2026-02-05T11:22:03.80843Z","steps":["trace[268604594] 'agreement among raft nodes before linearized reading'  (duration: 110.763257ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:22:04.276228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.530345ms","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-05T11:22:04.276987Z","caller":"traceutil/trace.go:171","msg":"trace[2113185332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1963; }","duration":"116.311882ms","start":"2026-02-05T11:22:04.160655Z","end":"2026-02-05T11:22:04.276966Z","steps":["trace[2113185332] 'range keys from in-memory index tree'  (duration: 115.427992ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:22:04.276509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.872492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-05T11:22:04.279824Z","caller":"traceutil/trace.go:171","msg":"trace[1607514773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1963; }","duration":"111.215117ms","start":"2026-02-05T11:22:04.168596Z","end":"2026-02-05T11:22:04.279811Z","steps":["trace[1607514773] 'range keys from in-memory index tree'  (duration: 107.756669ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:22:04.528996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.136934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:22:04.529054Z","caller":"traceutil/trace.go:171","msg":"trace[2071930462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1968; }","duration":"107.238257ms","start":"2026-02-05T11:22:04.421802Z","end":"2026-02-05T11:22:04.52904Z","steps":["trace[2071930462] 'range keys from in-memory index tree'  (duration: 107.086413ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:22:04.530615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.032439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:1 size:339"}
{"level":"info","ts":"2026-02-05T11:22:04.53069Z","caller":"traceutil/trace.go:171","msg":"trace[167693034] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:1968; }","duration":"151.140871ms","start":"2026-02-05T11:22:04.379533Z","end":"2026-02-05T11:22:04.530674Z","steps":["trace[167693034] 'range keys from in-memory index tree'  (duration: 149.164246ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:22:07.751755Z","caller":"traceutil/trace.go:171","msg":"trace[761649772] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"132.011328ms","start":"2026-02-05T11:22:07.619729Z","end":"2026-02-05T11:22:07.75174Z","steps":["trace[761649772] 'process raft request'  (duration: 131.923896ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T11:22:07.75176Z","caller":"traceutil/trace.go:171","msg":"trace[1858963147] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2061; }","duration":"107.445572ms","start":"2026-02-05T11:22:07.644289Z","end":"2026-02-05T11:22:07.751734Z","steps":["trace[1858963147] 'read index received'  (duration: 107.437101ms)","trace[1858963147] 'applied index is now lower than readState.Index'  (duration: 7.191µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T11:22:07.752021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.701848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/default/\" range_end:\"/registry/statefulsets/default0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:22:07.752079Z","caller":"traceutil/trace.go:171","msg":"trace[2141263123] range","detail":"{range_begin:/registry/statefulsets/default/; range_end:/registry/statefulsets/default0; response_count:0; response_revision:1979; }","duration":"107.80354ms","start":"2026-02-05T11:22:07.644262Z","end":"2026-02-05T11:22:07.752065Z","steps":["trace[2141263123] 'agreement among raft nodes before linearized reading'  (duration: 107.632446ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T11:22:14.539662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.095796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T11:22:14.54005Z","caller":"traceutil/trace.go:171","msg":"trace[12799682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2006; }","duration":"100.500295ms","start":"2026-02-05T11:22:14.439531Z","end":"2026-02-05T11:22:14.540031Z","steps":["trace[12799682] 'range keys from in-memory index tree'  (duration: 100.057265ms)"],"step_count":1}