{"level":"warn","ts":"2026-03-02T02:09:50.743514Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-02T02:09:50.743625Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-02T02:09:50.745922Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-02T02:09:50.745947Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]}
{"level":"info","ts":"2026-03-02T02:09:50.745977Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-02T02:09:50.747291Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]}
{"level":"info","ts":"2026-03-02T02:09:50.74746Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-02T02:09:50.752444Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.541659ms"}
{"level":"info","ts":"2026-03-02T02:09:50.762401Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"}
{"level":"info","ts":"2026-03-02T02:09:50.76247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-02T02:09:50.762494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"}
{"level":"info","ts":"2026-03-02T02:09:50.76253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-02T02:09:50.76254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"}
{"level":"info","ts":"2026-03-02T02:09:50.762587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"}
{"level":"warn","ts":"2026-03-02T02:09:50.774156Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-02T02:09:50.777585Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-02T02:09:50.779442Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-02T02:09:50.78134Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-02T02:09:50.782213Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-02T02:09:50.781829Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-02T02:09:50.782998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"}
{"level":"info","ts":"2026-03-02T02:09:50.783129Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-02T02:09:50.783189Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-02T02:09:50.783712Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]}
{"level":"info","ts":"2026-03-02T02:09:50.785535Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-02T02:09:50.785694Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"}
{"level":"info","ts":"2026-03-02T02:09:50.785734Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"}
{"level":"info","ts":"2026-03-02T02:09:50.786822Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-02T02:09:50.787119Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-02T02:09:51.264116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-02T02:09:51.264182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-02T02:09:51.264221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"}
{"level":"info","ts":"2026-03-02T02:09:51.266376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"}
{"level":"info","ts":"2026-03-02T02:09:51.266502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"}
{"level":"info","ts":"2026-03-02T02:09:51.266532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"}
{"level":"info","ts":"2026-03-02T02:09:51.266546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"}
{"level":"info","ts":"2026-03-02T02:09:51.267731Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-02T02:09:51.282571Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-02T02:09:51.282625Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-02T02:09:51.282756Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-02T02:09:51.2833Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-02T02:09:51.283374Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-02T02:09:51.283398Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-02T02:09:51.284394Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"}
{"level":"info","ts":"2026-03-02T02:09:51.285858Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-02T02:09:51.288625Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-02T02:09:51.288652Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-02T02:09:52.984811Z","caller":"traceutil/trace.go:171","msg":"trace[143814170] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"416.073272ms","start":"2026-03-02T02:09:52.568714Z","end":"2026-03-02T02:09:52.984787Z","steps":["trace[143814170] 'read index received'  (duration: 415.901048ms)","trace[143814170] 'applied index is now lower than readState.Index'  (duration: 171.124µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:09:52.98487Z","caller":"traceutil/trace.go:171","msg":"trace[1022047546] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"419.713019ms","start":"2026-03-02T02:09:52.565116Z","end":"2026-03-02T02:09:52.984829Z","steps":["trace[1022047546] 'process raft request'  (duration: 419.481144ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:52.985065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.290947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:52.98523Z","caller":"traceutil/trace.go:171","msg":"trace[59202494] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2; }","duration":"416.483562ms","start":"2026-03-02T02:09:52.568705Z","end":"2026-03-02T02:09:52.985188Z","steps":["trace[59202494] 'agreement among raft nodes before linearized reading'  (duration: 416.206725ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:52.985367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.568699Z","time spent":"416.649086ms","remote":"127.0.0.1:33324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "}
{"level":"warn","ts":"2026-03-02T02:09:52.985949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.565106Z","time spent":"419.988326ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/servicenodeports\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/servicenodeports\" value_size:66 >> failure:<request_range:<key:\"/registry/ranges/servicenodeports\" > >"}
{"level":"warn","ts":"2026-03-02T02:09:53.485671Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635443071,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-02T02:09:53.747164Z","caller":"traceutil/trace.go:171","msg":"trace[414116262] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.099107375s","start":"2026-03-02T02:09:52.648028Z","end":"2026-03-02T02:09:53.747136Z","steps":["trace[414116262] 'process raft request'  (duration: 1.099005922s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.647999Z","time spent":"1.099288939s","remote":"127.0.0.1:33708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:09:53.747308Z","caller":"traceutil/trace.go:171","msg":"trace[1974074360] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.099221437s","start":"2026-03-02T02:09:52.648013Z","end":"2026-03-02T02:09:53.747234Z","steps":["trace[1974074360] 'process raft request'  (duration: 1.098890019s)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:09:53.747358Z","caller":"traceutil/trace.go:171","msg":"trace[1493126553] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"762.437789ms","start":"2026-03-02T02:09:52.984891Z","end":"2026-03-02T02:09:53.747329Z","steps":["trace[1493126553] 'read index received'  (duration: 761.931237ms)","trace[1493126553] 'applied index is now lower than readState.Index'  (duration: 505.722µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:09:53.74743Z","caller":"traceutil/trace.go:171","msg":"trace[1817041945] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.09474376s","start":"2026-03-02T02:09:52.652668Z","end":"2026-03-02T02:09:53.747411Z","steps":["trace[1817041945] 'process raft request'  (duration: 1.094594857s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.647984Z","time spent":"1.099407762s","remote":"127.0.0.1:33708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"warn","ts":"2026-03-02T02:09:53.747517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.652656Z","time spent":"1.094812932s","remote":"127.0.0.1:33402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-xc46z\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-xc46z\" value_size:795 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:09:53.74767Z","caller":"traceutil/trace.go:171","msg":"trace[417062128] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.099389421s","start":"2026-03-02T02:09:52.64827Z","end":"2026-03-02T02:09:53.747659Z","steps":["trace[417062128] 'process raft request'  (duration: 1.098795477s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102698502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-02T02:09:53.747728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.648238Z","time spent":"1.099467234s","remote":"127.0.0.1:33708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"warn","ts":"2026-03-02T02:09:53.747735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130685464s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:53.747759Z","caller":"traceutil/trace.go:171","msg":"trace[1094534421] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:0; response_revision:10; }","duration":"1.102735133s","start":"2026-03-02T02:09:52.645012Z","end":"2026-03-02T02:09:53.747747Z","steps":["trace[1094534421] 'agreement among raft nodes before linearized reading'  (duration: 1.102579319s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.644928Z","time spent":"1.102861636s","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.132\" "}
{"level":"info","ts":"2026-03-02T02:09:53.747795Z","caller":"traceutil/trace.go:171","msg":"trace[611418018] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.130789106s","start":"2026-03-02T02:09:52.616992Z","end":"2026-03-02T02:09:53.747781Z","steps":["trace[611418018] 'agreement among raft nodes before linearized reading'  (duration: 1.130639013s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16967287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-02T02:09:53.747831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.616975Z","time spent":"1.130847947s","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-02T02:09:53.747844Z","caller":"traceutil/trace.go:171","msg":"trace[405581239] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"1.169759082s","start":"2026-03-02T02:09:52.578076Z","end":"2026-03-02T02:09:53.747835Z","steps":["trace[405581239] 'agreement among raft nodes before linearized reading'  (duration: 1.16968558s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.57806Z","time spent":"1.169801913s","remote":"127.0.0.1:33544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-03-02T02:09:53.747859Z","caller":"traceutil/trace.go:171","msg":"trace[681000932] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.099477924s","start":"2026-03-02T02:09:52.648369Z","end":"2026-03-02T02:09:53.747847Z","steps":["trace[681000932] 'process raft request'  (duration: 1.098719886s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.747741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.762686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:53.748002Z","caller":"traceutil/trace.go:171","msg":"trace[593306969] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.09226518s","start":"2026-03-02T02:09:52.655727Z","end":"2026-03-02T02:09:53.747992Z","steps":["trace[593306969] 'process raft request'  (duration: 1.091568474s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.648355Z","time spent":"1.099611717s","remote":"127.0.0.1:33708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:09:53.748027Z","caller":"traceutil/trace.go:171","msg":"trace[1218370710] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"760.107974ms","start":"2026-03-02T02:09:52.987908Z","end":"2026-03-02T02:09:53.748016Z","steps":["trace[1218370710] 'agreement among raft nodes before linearized reading'  (duration: 759.790156ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.655714Z","time spent":"1.092313402s","remote":"127.0.0.1:33298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"warn","ts":"2026-03-02T02:09:53.74806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.98789Z","time spent":"760.160805ms","remote":"127.0.0.1:33184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-03-02T02:09:53.747968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.313579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:53.748145Z","caller":"traceutil/trace.go:171","msg":"trace[357644043] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"202.505443ms","start":"2026-03-02T02:09:53.545631Z","end":"2026-03-02T02:09:53.748136Z","steps":["trace[357644043] 'agreement among raft nodes before linearized reading'  (duration: 202.318088ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:09:53.748151Z","caller":"traceutil/trace.go:171","msg":"trace[806051203] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.099494274s","start":"2026-03-02T02:09:52.648634Z","end":"2026-03-02T02:09:53.748129Z","steps":["trace[806051203] 'process raft request'  (duration: 1.098478109s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048332626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-02T02:09:53.748194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.648595Z","time spent":"1.099579406s","remote":"127.0.0.1:33708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:09:53.748272Z","caller":"traceutil/trace.go:171","msg":"trace[1141161927] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.048431468s","start":"2026-03-02T02:09:52.699831Z","end":"2026-03-02T02:09:53.748262Z","steps":["trace[1141161927] 'agreement among raft nodes before linearized reading'  (duration: 1.048333506s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.699823Z","time spent":"1.048470279s","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-02T02:09:53.748465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099877764s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:53.748495Z","caller":"traceutil/trace.go:171","msg":"trace[1660178103] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.099936385s","start":"2026-03-02T02:09:52.648548Z","end":"2026-03-02T02:09:53.748484Z","steps":["trace[1660178103] 'agreement among raft nodes before linearized reading'  (duration: 1.099892834s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.648534Z","time spent":"1.099985516s","remote":"127.0.0.1:33208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"info","ts":"2026-03-02T02:09:53.74853Z","caller":"traceutil/trace.go:171","msg":"trace[2121367734] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.099860023s","start":"2026-03-02T02:09:52.648659Z","end":"2026-03-02T02:09:53.748519Z","steps":["trace[2121367734] 'process raft request'  (duration: 1.098569912s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.648637Z","time spent":"1.099920054s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-03-02T02:09:53.748658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100515408s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:53.748683Z","caller":"traceutil/trace.go:171","msg":"trace[1275677831] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.100575s","start":"2026-03-02T02:09:52.6481Z","end":"2026-03-02T02:09:53.748675Z","steps":["trace[1275677831] 'agreement among raft nodes before linearized reading'  (duration: 1.100536469s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:09:53.748711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:09:52.648089Z","time spent":"1.100616872s","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-02T02:09:53.753318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.945344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-02T02:09:53.75336Z","caller":"traceutil/trace.go:171","msg":"trace[1997016452] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"208.023436ms","start":"2026-03-02T02:09:53.545327Z","end":"2026-03-02T02:09:53.753351Z","steps":["trace[1997016452] 'agreement among raft nodes before linearized reading'  (duration: 202.929084ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:19.513536Z","caller":"traceutil/trace.go:171","msg":"trace[197978515] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"217.731518ms","start":"2026-03-02T02:10:19.295768Z","end":"2026-03-02T02:10:19.513499Z","steps":["trace[197978515] 'process raft request'  (duration: 217.596755ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:26.661981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.361264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:26.662078Z","caller":"traceutil/trace.go:171","msg":"trace[126870436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"390.508008ms","start":"2026-03-02T02:10:26.271546Z","end":"2026-03-02T02:10:26.662054Z","steps":["trace[126870436] 'range keys from in-memory index tree'  (duration: 390.269032ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:26.662244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:26.271523Z","time spent":"390.694102ms","remote":"127.0.0.1:33106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:10:27.770879Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444085,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-02T02:10:27.954636Z","caller":"traceutil/trace.go:171","msg":"trace[2145939231] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"953.16403ms","start":"2026-03-02T02:10:27.001438Z","end":"2026-03-02T02:10:27.954602Z","steps":["trace[2145939231] 'process raft request'  (duration: 952.984025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:27.954815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:27.001411Z","time spent":"953.319174ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:524 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-02T02:10:27.988578Z","caller":"traceutil/trace.go:171","msg":"trace[1960064046] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"610.948331ms","start":"2026-03-02T02:10:27.377608Z","end":"2026-03-02T02:10:27.988556Z","steps":["trace[1960064046] 'process raft request'  (duration: 610.761807ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:27.988712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:27.377582Z","time spent":"611.062014ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:470 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-02T02:10:27.988718Z","caller":"traceutil/trace.go:171","msg":"trace[128892504] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:550; }","duration":"718.385722ms","start":"2026-03-02T02:10:27.27031Z","end":"2026-03-02T02:10:27.988696Z","steps":["trace[128892504] 'read index received'  (duration: 684.110638ms)","trace[128892504] 'applied index is now lower than readState.Index'  (duration: 34.273684ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:27.988813Z","caller":"traceutil/trace.go:171","msg":"trace[966393788] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"577.808586ms","start":"2026-03-02T02:10:27.410974Z","end":"2026-03-02T02:10:27.988783Z","steps":["trace[966393788] 'process raft request'  (duration: 577.536429ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:27.988907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.524316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:27.988943Z","caller":"traceutil/trace.go:171","msg":"trace[1762017492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"718.667908ms","start":"2026-03-02T02:10:27.270262Z","end":"2026-03-02T02:10:27.98893Z","steps":["trace[1762017492] 'agreement among raft nodes before linearized reading'  (duration: 718.537155ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:27.98896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:27.410948Z","time spent":"577.911258ms","remote":"127.0.0.1:33298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4745,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:513 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4711 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-02T02:10:27.988972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.691446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-02T02:10:27.988993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:27.270242Z","time spent":"718.71992ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-02T02:10:27.989022Z","caller":"traceutil/trace.go:171","msg":"trace[326787099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"448.767707ms","start":"2026-03-02T02:10:27.540239Z","end":"2026-03-02T02:10:27.989007Z","steps":["trace[326787099] 'agreement among raft nodes before linearized reading'  (duration: 448.598513ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:27.989056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:27.540224Z","time spent":"448.824028ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-02T02:10:28.595724Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444093,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:10:28.943616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.20371ms","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-03-02T02:10:28.943799Z","caller":"traceutil/trace.go:171","msg":"trace[23046773] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:535; }","duration":"619.398364ms","start":"2026-03-02T02:10:28.324377Z","end":"2026-03-02T02:10:28.943775Z","steps":["trace[23046773] 'range keys from in-memory index tree'  (duration: 619.186389ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:28.943911Z","caller":"traceutil/trace.go:171","msg":"trace[1250944696] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:554; }","duration":"848.544067ms","start":"2026-03-02T02:10:28.09534Z","end":"2026-03-02T02:10:28.943884Z","steps":["trace[1250944696] 'read index received'  (duration: 793.882294ms)","trace[1250944696] 'applied index is now lower than readState.Index'  (duration: 54.660723ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:28.944037Z","caller":"traceutil/trace.go:171","msg":"trace[971885334] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"879.85438ms","start":"2026-03-02T02:10:28.064146Z","end":"2026-03-02T02:10:28.944001Z","steps":["trace[971885334] 'process raft request'  (duration: 825.090415ms)","trace[971885334] 'compare'  (duration: 53.989566ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:10:28.944169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.816094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-02T02:10:28.944071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.888695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:10:28.944204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:28.064129Z","time spent":"879.994063ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:530 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:10:28.94424Z","caller":"traceutil/trace.go:171","msg":"trace[1093901870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"848.950317ms","start":"2026-03-02T02:10:28.095275Z","end":"2026-03-02T02:10:28.944225Z","steps":["trace[1093901870] 'agreement among raft nodes before linearized reading'  (duration: 848.741422ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:28.944242Z","caller":"traceutil/trace.go:171","msg":"trace[2130858966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"672.107ms","start":"2026-03-02T02:10:28.272122Z","end":"2026-03-02T02:10:28.944229Z","steps":["trace[2130858966] 'agreement among raft nodes before linearized reading'  (duration: 671.903355ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:28.94427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:28.095212Z","time spent":"849.05241ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-02T02:10:28.94428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:28.272103Z","time spent":"672.166722ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-02T02:10:29.569507Z","caller":"traceutil/trace.go:171","msg":"trace[2140834317] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"298.075528ms","start":"2026-03-02T02:10:29.271412Z","end":"2026-03-02T02:10:29.569488Z","steps":["trace[2140834317] 'read index received'  (duration: 220.157057ms)","trace[2140834317] 'applied index is now lower than readState.Index'  (duration: 77.917791ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:10:29.569625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.211972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:29.569645Z","caller":"traceutil/trace.go:171","msg":"trace[537476134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"298.302804ms","start":"2026-03-02T02:10:29.271336Z","end":"2026-03-02T02:10:29.569639Z","steps":["trace[537476134] 'agreement among raft nodes before linearized reading'  (duration: 298.216332ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:29.569752Z","caller":"traceutil/trace.go:171","msg":"trace[1704223703] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"621.043125ms","start":"2026-03-02T02:10:28.948681Z","end":"2026-03-02T02:10:29.569724Z","steps":["trace[1704223703] 'process raft request'  (duration: 542.96485ms)","trace[1704223703] 'compare'  (duration: 77.761517ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:10:29.569899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:28.948664Z","time spent":"621.160507ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:531 > 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-03-02T02:10:30.95987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.907432ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444112 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-operator-869df985b8-zqqx2.1898e44335345957\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-operator-869df985b8-zqqx2.1898e44335345957\" value_size:667 lease:256877442635443415 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:10:30.959969Z","caller":"traceutil/trace.go:171","msg":"trace[348496634] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:564; }","duration":"122.149904ms","start":"2026-03-02T02:10:30.837804Z","end":"2026-03-02T02:10:30.959954Z","steps":["trace[348496634] 'read index received'  (duration: 58.592µs)","trace[348496634] 'applied index is now lower than readState.Index'  (duration: 122.090202ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:30.960048Z","caller":"traceutil/trace.go:171","msg":"trace[1070118043] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"280.977608ms","start":"2026-03-02T02:10:30.679061Z","end":"2026-03-02T02:10:30.960038Z","steps":["trace[1070118043] 'compare'  (duration: 279.788709ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:30.960702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.874281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-02T02:10:30.960788Z","caller":"traceutil/trace.go:171","msg":"trace[1950880235] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:545; }","duration":"122.993094ms","start":"2026-03-02T02:10:30.837773Z","end":"2026-03-02T02:10:30.960766Z","steps":["trace[1950880235] 'agreement among raft nodes before linearized reading'  (duration: 122.661316ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:31.114459Z","caller":"traceutil/trace.go:171","msg":"trace[1431483890] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:565; }","duration":"139.121631ms","start":"2026-03-02T02:10:30.975317Z","end":"2026-03-02T02:10:31.114438Z","steps":["trace[1431483890] 'read index received'  (duration: 113.568218ms)","trace[1431483890] 'applied index is now lower than readState.Index'  (duration: 25.552813ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:10:31.114563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.226634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:31.114588Z","caller":"traceutil/trace.go:171","msg":"trace[141694692] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:546; }","duration":"139.296685ms","start":"2026-03-02T02:10:30.975285Z","end":"2026-03-02T02:10:31.114581Z","steps":["trace[141694692] 'agreement among raft nodes before linearized reading'  (duration: 139.223863ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:31.114727Z","caller":"traceutil/trace.go:171","msg":"trace[1233065443] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"150.195647ms","start":"2026-03-02T02:10:30.964505Z","end":"2026-03-02T02:10:31.1147Z","steps":["trace[1233065443] 'process raft request'  (duration: 124.370097ms)","trace[1233065443] 'compare'  (duration: 25.464711ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:34.905918Z","caller":"traceutil/trace.go:171","msg":"trace[1668293652] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"128.577318ms","start":"2026-03-02T02:10:34.777314Z","end":"2026-03-02T02:10:34.905891Z","steps":["trace[1668293652] 'process raft request'  (duration: 125.636387ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:34.908011Z","caller":"traceutil/trace.go:171","msg":"trace[532612914] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"124.059699ms","start":"2026-03-02T02:10:34.783925Z","end":"2026-03-02T02:10:34.907984Z","steps":["trace[532612914] 'process raft request'  (duration: 123.755082ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:40.574295Z","caller":"traceutil/trace.go:171","msg":"trace[1690275292] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"120.332319ms","start":"2026-03-02T02:10:40.453932Z","end":"2026-03-02T02:10:40.574264Z","steps":["trace[1690275292] 'process raft request'  (duration: 120.125914ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:42.211134Z","caller":"traceutil/trace.go:171","msg":"trace[325287284] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"141.56523ms","start":"2026-03-02T02:10:42.069547Z","end":"2026-03-02T02:10:42.211112Z","steps":["trace[325287284] 'process raft request'  (duration: 141.332154ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:47.168875Z","caller":"traceutil/trace.go:171","msg":"trace[2124141784] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"115.389847ms","start":"2026-03-02T02:10:47.053469Z","end":"2026-03-02T02:10:47.168859Z","steps":["trace[2124141784] 'process raft request'  (duration: 113.630875ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:47.194374Z","caller":"traceutil/trace.go:171","msg":"trace[1462705179] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"135.424281ms","start":"2026-03-02T02:10:47.058911Z","end":"2026-03-02T02:10:47.194335Z","steps":["trace[1462705179] 'process raft request'  (duration: 135.322448ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:48.738982Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444392,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:10:49.157216Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.393020645s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-02T02:10:49.157634Z","caller":"traceutil/trace.go:171","msg":"trace[1270121801] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"1.393509597s","start":"2026-03-02T02:10:47.764088Z","end":"2026-03-02T02:10:49.157598Z","steps":["trace[1270121801] 'process raft request'  (duration: 1.393357903s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.157764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:47.764069Z","time spent":"1.39363219s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:659 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:10:49.175754Z","caller":"traceutil/trace.go:171","msg":"trace[1243532614] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:700; }","duration":"937.088432ms","start":"2026-03-02T02:10:48.238633Z","end":"2026-03-02T02:10:49.175721Z","steps":["trace[1243532614] 'read index received'  (duration: 918.896872ms)","trace[1243532614] 'applied index is now lower than readState.Index'  (duration: 18.19035ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:49.176184Z","caller":"traceutil/trace.go:171","msg":"trace[932670894] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"1.068553778s","start":"2026-03-02T02:10:48.107597Z","end":"2026-03-02T02:10:49.176151Z","steps":["trace[932670894] 'process raft request'  (duration: 1.06779039s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.176294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:48.107571Z","time spent":"1.068645111s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:634 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-02T02:10:49.176593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.961112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-02T02:10:49.176627Z","caller":"traceutil/trace.go:171","msg":"trace[1102269327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:678; }","duration":"938.046875ms","start":"2026-03-02T02:10:48.238569Z","end":"2026-03-02T02:10:49.176616Z","steps":["trace[1102269327] 'agreement among raft nodes before linearized reading'  (duration: 937.916262ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.176657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:48.238546Z","time spent":"938.104736ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-02T02:10:49.176805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.734131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:49.17683Z","caller":"traceutil/trace.go:171","msg":"trace[2141225951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"905.783432ms","start":"2026-03-02T02:10:48.271039Z","end":"2026-03-02T02:10:49.176822Z","steps":["trace[2141225951] 'agreement among raft nodes before linearized reading'  (duration: 905.745311ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.176853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:48.271019Z","time spent":"905.829544ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:10:49.177112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.709037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-02T02:10:49.177141Z","caller":"traceutil/trace.go:171","msg":"trace[1813311887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:678; }","duration":"893.753908ms","start":"2026-03-02T02:10:48.283378Z","end":"2026-03-02T02:10:49.177132Z","steps":["trace[1813311887] 'agreement among raft nodes before linearized reading'  (duration: 893.673106ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.177191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:48.283369Z","time spent":"893.813649ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-02T02:10:49.709442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.19889ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444399 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:661 > 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-03-02T02:10:49.709535Z","caller":"traceutil/trace.go:171","msg":"trace[502855532] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"434.60249ms","start":"2026-03-02T02:10:49.274917Z","end":"2026-03-02T02:10:49.70952Z","steps":["trace[502855532] 'read index received'  (duration: 214.065µs)","trace[502855532] 'applied index is now lower than readState.Index'  (duration: 434.387385ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:49.709598Z","caller":"traceutil/trace.go:171","msg":"trace[1381597677] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"529.283397ms","start":"2026-03-02T02:10:49.180304Z","end":"2026-03-02T02:10:49.709588Z","steps":["trace[1381597677] 'process raft request'  (duration: 94.844511ms)","trace[1381597677] 'compare'  (duration: 434.100818ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:10:49.709649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.180279Z","time spent":"529.342428ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:661 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-02T02:10:49.709904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.991539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-02T02:10:49.709931Z","caller":"traceutil/trace.go:171","msg":"trace[29545121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:680; }","duration":"435.05971ms","start":"2026-03-02T02:10:49.274862Z","end":"2026-03-02T02:10:49.709922Z","steps":["trace[29545121] 'agreement among raft nodes before linearized reading'  (duration: 434.953718ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.709958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.27484Z","time spent":"435.111652ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-02T02:10:49.710737Z","caller":"traceutil/trace.go:171","msg":"trace[1009126126] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"354.138058ms","start":"2026-03-02T02:10:49.356577Z","end":"2026-03-02T02:10:49.710715Z","steps":["trace[1009126126] 'process raft request'  (duration: 354.028705ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.710886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.365995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:10:49.71093Z","caller":"traceutil/trace.go:171","msg":"trace[916757107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:681; }","duration":"382.438167ms","start":"2026-03-02T02:10:49.328474Z","end":"2026-03-02T02:10:49.710913Z","steps":["trace[916757107] 'agreement among raft nodes before linearized reading'  (duration: 382.318464ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.71097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.328451Z","time spent":"382.510859ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-02T02:10:49.710883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.356556Z","time spent":"354.252171ms","remote":"127.0.0.1:37022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1238,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/34353\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/34353\" value_size:1188 >> failure:<>"}
{"level":"warn","ts":"2026-03-02T02:10:49.710747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.582614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:49.71114Z","caller":"traceutil/trace.go:171","msg":"trace[608076652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:681; }","duration":"431.010695ms","start":"2026-03-02T02:10:49.280117Z","end":"2026-03-02T02:10:49.711128Z","steps":["trace[608076652] 'agreement among raft nodes before linearized reading'  (duration: 430.571724ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:49.711179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.2801Z","time spent":"431.066285ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:10:50.771512Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444402,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:10:50.778725Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.064948875s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-02T02:10:50.779371Z","caller":"traceutil/trace.go:171","msg":"trace[464607851] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"1.065635511s","start":"2026-03-02T02:10:49.713701Z","end":"2026-03-02T02:10:50.779337Z","steps":["trace[464607851] 'process raft request'  (duration: 1.065265062s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:50.77951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.713684Z","time spent":"1.065753593s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:674 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:10:50.798113Z","caller":"traceutil/trace.go:171","msg":"trace[689432779] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"1.081913455s","start":"2026-03-02T02:10:49.716167Z","end":"2026-03-02T02:10:50.798081Z","steps":["trace[689432779] 'process raft request'  (duration: 1.081683209s)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:50.79821Z","caller":"traceutil/trace.go:171","msg":"trace[1998659948] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"1.079349145s","start":"2026-03-02T02:10:49.718845Z","end":"2026-03-02T02:10:50.798187Z","steps":["trace[1998659948] 'process raft request'  (duration: 1.079119049s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:50.79828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.716147Z","time spent":"1.082056589s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:676 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:10:50.798293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.718836Z","time spent":"1.079414546s","remote":"127.0.0.1:53288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2260,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-5lmzc\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-5lmzc\" value_size:2180 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:10:50.800928Z","caller":"traceutil/trace.go:171","msg":"trace[567427679] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:705; }","duration":"529.446921ms","start":"2026-03-02T02:10:50.271465Z","end":"2026-03-02T02:10:50.800912Z","steps":["trace[567427679] 'read index received'  (duration: 507.81743ms)","trace[567427679] 'applied index is now lower than readState.Index'  (duration: 21.628591ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:10:50.801032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.560433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:10:50.801073Z","caller":"traceutil/trace.go:171","msg":"trace[1851282590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"529.642335ms","start":"2026-03-02T02:10:50.271418Z","end":"2026-03-02T02:10:50.80106Z","steps":["trace[1851282590] 'agreement among raft nodes before linearized reading'  (duration: 529.557773ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:50.801112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:50.2714Z","time spent":"529.702537ms","remote":"127.0.0.1:33106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-02T02:10:50.801399Z","caller":"traceutil/trace.go:171","msg":"trace[992082192] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"853.814375ms","start":"2026-03-02T02:10:49.947573Z","end":"2026-03-02T02:10:50.801387Z","steps":["trace[992082192] 'process raft request'  (duration: 853.251772ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:50.801462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:49.947553Z","time spent":"853.873017ms","remote":"127.0.0.1:53288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2260,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-67659f764b-pd9j5\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-67659f764b-pd9j5\" value_size:2180 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:10:59.06269Z","caller":"traceutil/trace.go:171","msg":"trace[1975391868] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"200.729452ms","start":"2026-03-02T02:10:58.861936Z","end":"2026-03-02T02:10:59.062665Z","steps":["trace[1975391868] 'read index received'  (duration: 200.63522ms)","trace[1975391868] 'applied index is now lower than readState.Index'  (duration: 93.232µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:10:59.062764Z","caller":"traceutil/trace.go:171","msg":"trace[1191038945] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"238.755831ms","start":"2026-03-02T02:10:58.823981Z","end":"2026-03-02T02:10:59.062737Z","steps":["trace[1191038945] 'process raft request'  (duration: 238.554286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:10:59.063001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.052129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:10:59.06308Z","caller":"traceutil/trace.go:171","msg":"trace[1416007007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:746; }","duration":"201.179853ms","start":"2026-03-02T02:10:58.861882Z","end":"2026-03-02T02:10:59.063062Z","steps":["trace[1416007007] 'agreement among raft nodes before linearized reading'  (duration: 200.893986ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:10:59.342466Z","caller":"traceutil/trace.go:171","msg":"trace[1172331563] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"139.013925ms","start":"2026-03-02T02:10:59.20341Z","end":"2026-03-02T02:10:59.342424Z","steps":["trace[1172331563] 'process raft request'  (duration: 138.831531ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:00.052095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444528,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:11:00.552641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444528,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:11:01.053019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444528,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:11:01.303259Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.84304975s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-02T02:11:01.373361Z","caller":"traceutil/trace.go:171","msg":"trace[968392871] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"1.913213328s","start":"2026-03-02T02:10:59.460121Z","end":"2026-03-02T02:11:01.373334Z","steps":["trace[968392871] 'process raft request'  (duration: 1.84344971s)","trace[968392871] 'compare'  (duration: 69.295487ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:01.373507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:59.460101Z","time spent":"1.913334521s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:678 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:01.64201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.815625ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444531 > lease_revoke:<id:03909cac4f18b07c>","response":"size:28"}
{"level":"info","ts":"2026-03-02T02:11:01.642178Z","caller":"traceutil/trace.go:171","msg":"trace[995904243] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:777; }","duration":"2.090459327s","start":"2026-03-02T02:10:59.551696Z","end":"2026-03-02T02:11:01.642156Z","steps":["trace[995904243] 'read index received'  (duration: 1.751860636s)","trace[995904243] 'applied index is now lower than readState.Index'  (duration: 338.596191ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:01.642309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.090584529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-02T02:11:01.642381Z","caller":"traceutil/trace.go:171","msg":"trace[200809344] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:750; }","duration":"2.090702532s","start":"2026-03-02T02:10:59.551661Z","end":"2026-03-02T02:11:01.642364Z","steps":["trace[200809344] 'agreement among raft nodes before linearized reading'  (duration: 2.090566459s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.642402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.886712602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-02T02:11:01.642414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:59.551645Z","time spent":"2.090762184s","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"info","ts":"2026-03-02T02:11:01.642436Z","caller":"traceutil/trace.go:171","msg":"trace[661471785] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:750; }","duration":"1.886797744s","start":"2026-03-02T02:10:59.755629Z","end":"2026-03-02T02:11:01.642427Z","steps":["trace[661471785] 'agreement among raft nodes before linearized reading'  (duration: 1.88664875s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.642427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.668962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:11:01.642472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:10:59.755609Z","time spent":"1.886854836s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-02T02:11:01.642485Z","caller":"traceutil/trace.go:171","msg":"trace[1237233134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"371.759725ms","start":"2026-03-02T02:11:01.270709Z","end":"2026-03-02T02:11:01.642469Z","steps":["trace[1237233134] 'agreement among raft nodes before linearized reading'  (duration: 371.642262ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.642519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.270693Z","time spent":"371.820246ms","remote":"127.0.0.1:33106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:11:01.642708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.12204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:01.642742Z","caller":"traceutil/trace.go:171","msg":"trace[1825791468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"677.186592ms","start":"2026-03-02T02:11:00.965547Z","end":"2026-03-02T02:11:01.642733Z","steps":["trace[1825791468] 'agreement among raft nodes before linearized reading'  (duration: 677.140131ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.64276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.312765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-02T02:11:01.642767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:00.965527Z","time spent":"677.234713ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-02T02:11:01.642785Z","caller":"traceutil/trace.go:171","msg":"trace[1545036098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"575.392136ms","start":"2026-03-02T02:11:01.067385Z","end":"2026-03-02T02:11:01.642778Z","steps":["trace[1545036098] 'agreement among raft nodes before linearized reading'  (duration: 575.268073ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.642792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.926543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-02T02:11:01.642808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.067365Z","time spent":"575.438328ms","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:11:01.642813Z","caller":"traceutil/trace.go:171","msg":"trace[626076721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"295.977264ms","start":"2026-03-02T02:11:01.34683Z","end":"2026-03-02T02:11:01.642807Z","steps":["trace[626076721] 'agreement among raft nodes before linearized reading'  (duration: 295.928703ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.642746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.919179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-02T02:11:01.642902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.67922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:11:01.64292Z","caller":"traceutil/trace.go:171","msg":"trace[943851524] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:750; }","duration":"530.742741ms","start":"2026-03-02T02:11:01.112171Z","end":"2026-03-02T02:11:01.642913Z","steps":["trace[943851524] 'agreement among raft nodes before linearized reading'  (duration: 530.68998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:01.64294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.112132Z","time spent":"530.804723ms","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:11:01.642914Z","caller":"traceutil/trace.go:171","msg":"trace[1167062950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:750; }","duration":"273.107003ms","start":"2026-03-02T02:11:01.369798Z","end":"2026-03-02T02:11:01.642905Z","steps":["trace[1167062950] 'agreement among raft nodes before linearized reading'  (duration: 272.865658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:01.884829Z","caller":"traceutil/trace.go:171","msg":"trace[760717423] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"238.569197ms","start":"2026-03-02T02:11:01.646245Z","end":"2026-03-02T02:11:01.884814Z","steps":["trace[760717423] 'process raft request'  (duration: 238.455735ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:02.165058Z","caller":"traceutil/trace.go:171","msg":"trace[1058074465] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"518.109423ms","start":"2026-03-02T02:11:01.646925Z","end":"2026-03-02T02:11:02.165034Z","steps":["trace[1058074465] 'process raft request'  (duration: 422.231357ms)","trace[1058074465] 'compare'  (duration: 95.586719ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:02.165317Z","caller":"traceutil/trace.go:171","msg":"trace[1648740283] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"518.166024ms","start":"2026-03-02T02:11:01.647134Z","end":"2026-03-02T02:11:02.1653Z","steps":["trace[1648740283] 'process raft request'  (duration: 517.819156ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.165399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.647128Z","time spent":"518.226055ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:747 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:11:02.165396Z","caller":"traceutil/trace.go:171","msg":"trace[578526395] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"518.162114ms","start":"2026-03-02T02:11:01.647199Z","end":"2026-03-02T02:11:02.165361Z","steps":["trace[578526395] 'process raft request'  (duration: 518.03249ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.165521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.647163Z","time spent":"518.290487ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:744 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-02T02:11:02.165624Z","caller":"traceutil/trace.go:171","msg":"trace[1129514206] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:779; }","duration":"373.113516ms","start":"2026-03-02T02:11:01.792484Z","end":"2026-03-02T02:11:02.165597Z","steps":["trace[1129514206] 'read index received'  (duration: 92.302041ms)","trace[1129514206] 'applied index is now lower than readState.Index'  (duration: 280.810455ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:02.165699Z","caller":"traceutil/trace.go:171","msg":"trace[1212062029] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"516.446673ms","start":"2026-03-02T02:11:01.649241Z","end":"2026-03-02T02:11:02.165688Z","steps":["trace[1212062029] 'process raft request'  (duration: 516.068244ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.165756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.649233Z","time spent":"516.493244ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:748 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:02.165809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.965772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:11:02.165807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.26656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:02.165861Z","caller":"traceutil/trace.go:171","msg":"trace[1736530715] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:755; }","duration":"359.019334ms","start":"2026-03-02T02:11:01.806814Z","end":"2026-03-02T02:11:02.165833Z","steps":["trace[1736530715] 'agreement among raft nodes before linearized reading'  (duration: 358.940822ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.165871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.386783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:02.165881Z","caller":"traceutil/trace.go:171","msg":"trace[1901755718] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:755; }","duration":"373.383323ms","start":"2026-03-02T02:11:01.792478Z","end":"2026-03-02T02:11:02.165861Z","steps":["trace[1901755718] 'agreement among raft nodes before linearized reading'  (duration: 373.26051ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:02.165903Z","caller":"traceutil/trace.go:171","msg":"trace[1054799336] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:755; }","duration":"373.441934ms","start":"2026-03-02T02:11:01.792451Z","end":"2026-03-02T02:11:02.165893Z","steps":["trace[1054799336] 'agreement among raft nodes before linearized reading'  (duration: 373.391903ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.165898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.806746Z","time spent":"359.141016ms","remote":"127.0.0.1:47524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-03-02T02:11:02.165927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.792437Z","time spent":"373.484606ms","remote":"127.0.0.1:47522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-03-02T02:11:02.165934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.792461Z","time spent":"373.461915ms","remote":"127.0.0.1:47522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-02T02:11:02.166025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.260189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:11:02.166058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.152488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:02.166067Z","caller":"traceutil/trace.go:171","msg":"trace[681940181] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:755; }","duration":"359.317451ms","start":"2026-03-02T02:11:01.806735Z","end":"2026-03-02T02:11:02.166053Z","steps":["trace[681940181] 'agreement among raft nodes before linearized reading'  (duration: 359.252759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:02.16609Z","caller":"traceutil/trace.go:171","msg":"trace[557519629] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:755; }","duration":"373.195719ms","start":"2026-03-02T02:11:01.792885Z","end":"2026-03-02T02:11:02.16608Z","steps":["trace[557519629] 'agreement among raft nodes before linearized reading'  (duration: 373.148197ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.166098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.806722Z","time spent":"359.367692ms","remote":"127.0.0.1:47524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "}
{"level":"warn","ts":"2026-03-02T02:11:02.166183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.792879Z","time spent":"373.235479ms","remote":"127.0.0.1:47522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
{"level":"warn","ts":"2026-03-02T02:11:02.166194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.224418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:02.166262Z","caller":"traceutil/trace.go:171","msg":"trace[1274777314] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:755; }","duration":"359.309821ms","start":"2026-03-02T02:11:01.806942Z","end":"2026-03-02T02:11:02.166252Z","steps":["trace[1274777314] 'agreement among raft nodes before linearized reading'  (duration: 359.217448ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:02.166294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.806934Z","time spent":"359.350761ms","remote":"127.0.0.1:47524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "}
{"level":"warn","ts":"2026-03-02T02:11:02.165205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:01.646909Z","time spent":"518.213605ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:746 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:11:20.795075Z","caller":"traceutil/trace.go:171","msg":"trace[1584905052] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"452.050321ms","start":"2026-03-02T02:11:20.343002Z","end":"2026-03-02T02:11:20.795053Z","steps":["trace[1584905052] 'process raft request'  (duration: 451.888367ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:20.795076Z","caller":"traceutil/trace.go:171","msg":"trace[2093476435] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:842; }","duration":"447.286938ms","start":"2026-03-02T02:11:20.347745Z","end":"2026-03-02T02:11:20.795032Z","steps":["trace[2093476435] 'read index received'  (duration: 447.175256ms)","trace[2093476435] 'applied index is now lower than readState.Index'  (duration: 110.672µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:20.795227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:20.342983Z","time spent":"452.150973ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:804 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:20.795198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.436152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:11:20.795448Z","caller":"traceutil/trace.go:171","msg":"trace[1269318988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:809; }","duration":"447.729769ms","start":"2026-03-02T02:11:20.347702Z","end":"2026-03-02T02:11:20.795432Z","steps":["trace[1269318988] 'agreement among raft nodes before linearized reading'  (duration: 447.379551ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:20.795601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:20.347684Z","time spent":"447.902323ms","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:11:22.416237Z","caller":"traceutil/trace.go:171","msg":"trace[1586916898] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"425.29154ms","start":"2026-03-02T02:11:21.990923Z","end":"2026-03-02T02:11:22.416215Z","steps":["trace[1586916898] 'read index received'  (duration: 424.938491ms)","trace[1586916898] 'applied index is now lower than readState.Index'  (duration: 352.238µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:22.416348Z","caller":"traceutil/trace.go:171","msg":"trace[2041186189] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"532.547643ms","start":"2026-03-02T02:11:21.883791Z","end":"2026-03-02T02:11:22.416339Z","steps":["trace[2041186189] 'process raft request'  (duration: 532.299438ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:22.416444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:21.883766Z","time spent":"532.607305ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:783 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:22.416507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.680562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:22.416581Z","caller":"traceutil/trace.go:171","msg":"trace[548344995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"145.786965ms","start":"2026-03-02T02:11:22.270775Z","end":"2026-03-02T02:11:22.416562Z","steps":["trace[548344995] 'agreement among raft nodes before linearized reading'  (duration: 145.681372ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:22.416841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.964905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-02T02:11:22.416895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.609413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-02T02:11:22.416898Z","caller":"traceutil/trace.go:171","msg":"trace[1112706446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"142.033616ms","start":"2026-03-02T02:11:22.27485Z","end":"2026-03-02T02:11:22.416883Z","steps":["trace[1112706446] 'agreement among raft nodes before linearized reading'  (duration: 141.868842ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:22.416941Z","caller":"traceutil/trace.go:171","msg":"trace[1673151274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"143.688155ms","start":"2026-03-02T02:11:22.273242Z","end":"2026-03-02T02:11:22.41693Z","steps":["trace[1673151274] 'agreement among raft nodes before linearized reading'  (duration: 143.538872ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:22.416967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.071838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-02T02:11:22.417015Z","caller":"traceutil/trace.go:171","msg":"trace[1286670557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"426.15899ms","start":"2026-03-02T02:11:21.990844Z","end":"2026-03-02T02:11:22.417003Z","steps":["trace[1286670557] 'agreement among raft nodes before linearized reading'  (duration: 425.939265ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:22.417087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:21.99082Z","time spent":"426.219541ms","remote":"127.0.0.1:33404","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-03-02T02:11:22.686493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.630125ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444703 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:807 > 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-03-02T02:11:22.686699Z","caller":"traceutil/trace.go:171","msg":"trace[360452847] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:846; }","duration":"156.866306ms","start":"2026-03-02T02:11:22.52981Z","end":"2026-03-02T02:11:22.686676Z","steps":["trace[360452847] 'read index received'  (duration: 28.923833ms)","trace[360452847] 'applied index is now lower than readState.Index'  (duration: 127.941073ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:22.68682Z","caller":"traceutil/trace.go:171","msg":"trace[1668320449] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"265.574775ms","start":"2026-03-02T02:11:22.421226Z","end":"2026-03-02T02:11:22.686801Z","steps":["trace[1668320449] 'process raft request'  (duration: 137.5301ms)","trace[1668320449] 'compare'  (duration: 127.469262ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:22.68713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.691415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:11:22.687122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.292957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:22.687194Z","caller":"traceutil/trace.go:171","msg":"trace[247246243] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:814; }","duration":"154.813858ms","start":"2026-03-02T02:11:22.532362Z","end":"2026-03-02T02:11:22.687176Z","steps":["trace[247246243] 'agreement among raft nodes before linearized reading'  (duration: 154.713886ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:22.687189Z","caller":"traceutil/trace.go:171","msg":"trace[1230080186] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"265.810931ms","start":"2026-03-02T02:11:22.42136Z","end":"2026-03-02T02:11:22.687171Z","steps":["trace[1230080186] 'process raft request'  (duration: 265.245938ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:22.68721Z","caller":"traceutil/trace.go:171","msg":"trace[547428880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"157.569844ms","start":"2026-03-02T02:11:22.52962Z","end":"2026-03-02T02:11:22.68719Z","steps":["trace[547428880] 'agreement among raft nodes before linearized reading'  (duration: 157.359539ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:22.905215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.733599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-02T02:11:22.905305Z","caller":"traceutil/trace.go:171","msg":"trace[1970497442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:814; }","duration":"105.863051ms","start":"2026-03-02T02:11:22.799421Z","end":"2026-03-02T02:11:22.905284Z","steps":["trace[1970497442] 'range keys from in-memory index tree'  (duration: 105.502503ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:23.05828Z","caller":"traceutil/trace.go:171","msg":"trace[1822530972] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"147.469454ms","start":"2026-03-02T02:11:22.910778Z","end":"2026-03-02T02:11:23.058247Z","steps":["trace[1822530972] 'process raft request'  (duration: 113.353668ms)","trace[1822530972] 'compare'  (duration: 33.946152ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:25.190985Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444716,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-02T02:11:25.583244Z","caller":"traceutil/trace.go:171","msg":"trace[956473039] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"1.106133517s","start":"2026-03-02T02:11:24.47708Z","end":"2026-03-02T02:11:25.583214Z","steps":["trace[956473039] 'process raft request'  (duration: 1.105890801s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:25.583415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:24.477062Z","time spent":"1.1062601s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:812 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-02T02:11:25.610572Z","caller":"traceutil/trace.go:171","msg":"trace[1989760864] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:851; }","duration":"920.070711ms","start":"2026-03-02T02:11:24.690477Z","end":"2026-03-02T02:11:25.610548Z","steps":["trace[1989760864] 'read index received'  (duration: 892.600491ms)","trace[1989760864] 'applied index is now lower than readState.Index'  (duration: 27.46932ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:25.610634Z","caller":"traceutil/trace.go:171","msg":"trace[1791084379] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"993.749372ms","start":"2026-03-02T02:11:24.616852Z","end":"2026-03-02T02:11:25.610602Z","steps":["trace[1791084379] 'process raft request'  (duration: 993.552507ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:25.610837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.935297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-02T02:11:25.610833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:24.616833Z","time spent":"993.893055ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.132\" mod_revision:794 > success:<request_put:<key:\"/registry/masterleases/199.204.45.132\" value_size:67 lease:256877442635444717 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.132\" > >"}
{"level":"info","ts":"2026-03-02T02:11:25.610882Z","caller":"traceutil/trace.go:171","msg":"trace[479649535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:818; }","duration":"919.996648ms","start":"2026-03-02T02:11:24.690874Z","end":"2026-03-02T02:11:25.61087Z","steps":["trace[479649535] 'agreement among raft nodes before linearized reading'  (duration: 919.808444ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:25.610876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.514695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-02T02:11:25.610885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.402288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-02T02:11:25.610863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.65324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-02T02:11:25.610923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:24.690839Z","time spent":"920.0756ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-02T02:11:25.610943Z","caller":"traceutil/trace.go:171","msg":"trace[1368526866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:818; }","duration":"920.495581ms","start":"2026-03-02T02:11:24.690432Z","end":"2026-03-02T02:11:25.610928Z","steps":["trace[1368526866] 'agreement among raft nodes before linearized reading'  (duration: 920.240815ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:25.61094Z","caller":"traceutil/trace.go:171","msg":"trace[1784374196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:818; }","duration":"629.610147ms","start":"2026-03-02T02:11:24.981309Z","end":"2026-03-02T02:11:25.610919Z","steps":["trace[1784374196] 'agreement among raft nodes before linearized reading'  (duration: 629.443113ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:25.610978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:24.690417Z","time spent":"920.554222ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-02T02:11:25.610985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:24.98129Z","time spent":"629.686429ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-02T02:11:25.611011Z","caller":"traceutil/trace.go:171","msg":"trace[1940726613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:818; }","duration":"547.785984ms","start":"2026-03-02T02:11:25.063151Z","end":"2026-03-02T02:11:25.610937Z","steps":["trace[1940726613] 'agreement among raft nodes before linearized reading'  (duration: 547.561299ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:25.611048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:25.063132Z","time spent":"547.908027ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-02T02:11:25.981193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.589224ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444724 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:814 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:11:25.981315Z","caller":"traceutil/trace.go:171","msg":"trace[729021609] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"365.628629ms","start":"2026-03-02T02:11:25.615666Z","end":"2026-03-02T02:11:25.981295Z","steps":["trace[729021609] 'process raft request'  (duration: 171.84054ms)","trace[729021609] 'compare'  (duration: 193.454431ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:25.981415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:25.615645Z","time spent":"365.703751ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:814 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:11:26.011834Z","caller":"traceutil/trace.go:171","msg":"trace[632782678] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:853; }","duration":"394.773508ms","start":"2026-03-02T02:11:25.617042Z","end":"2026-03-02T02:11:26.011816Z","steps":["trace[632782678] 'read index received'  (duration: 170.417477ms)","trace[632782678] 'applied index is now lower than readState.Index'  (duration: 224.354891ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:26.011929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.875961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-03-02T02:11:26.011964Z","caller":"traceutil/trace.go:171","msg":"trace[1846139781] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:822; }","duration":"394.956933ms","start":"2026-03-02T02:11:25.616998Z","end":"2026-03-02T02:11:26.011955Z","steps":["trace[1846139781] 'agreement among raft nodes before linearized reading'  (duration: 394.883421ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:26.012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:25.616979Z","time spent":"395.013603ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"info","ts":"2026-03-02T02:11:26.012125Z","caller":"traceutil/trace.go:171","msg":"trace[109612441] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"383.288747ms","start":"2026-03-02T02:11:25.628805Z","end":"2026-03-02T02:11:26.012094Z","steps":["trace[109612441] 'process raft request'  (duration: 382.923768ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:26.012856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:25.628797Z","time spent":"383.995593ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:813 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-02T02:11:26.012196Z","caller":"traceutil/trace.go:171","msg":"trace[699697780] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"381.207127ms","start":"2026-03-02T02:11:25.630956Z","end":"2026-03-02T02:11:26.012163Z","steps":["trace[699697780] 'process raft request'  (duration: 380.813188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:26.012217Z","caller":"traceutil/trace.go:171","msg":"trace[377264101] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"395.27394ms","start":"2026-03-02T02:11:25.616869Z","end":"2026-03-02T02:11:26.012143Z","steps":["trace[377264101] 'process raft request'  (duration: 394.768978ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:26.013156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:25.630947Z","time spent":"381.993806ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:815 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:26.0134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:25.616853Z","time spent":"396.284514ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:816 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:11:26.921297Z","caller":"traceutil/trace.go:171","msg":"trace[2060478471] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"198.199733ms","start":"2026-03-02T02:11:26.723071Z","end":"2026-03-02T02:11:26.921271Z","steps":["trace[2060478471] 'process raft request'  (duration: 197.994458ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:34.216731Z","caller":"traceutil/trace.go:171","msg":"trace[1240210592] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"110.810218ms","start":"2026-03-02T02:11:34.105881Z","end":"2026-03-02T02:11:34.216691Z","steps":["trace[1240210592] 'process raft request'  (duration: 110.590033ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:37.807262Z","caller":"traceutil/trace.go:171","msg":"trace[267544857] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"113.816059ms","start":"2026-03-02T02:11:37.693396Z","end":"2026-03-02T02:11:37.807212Z","steps":["trace[267544857] 'process raft request'  (duration: 113.505532ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:38.057441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.360361ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444856 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:846 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:11:38.057619Z","caller":"traceutil/trace.go:171","msg":"trace[1632729734] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"245.641725ms","start":"2026-03-02T02:11:37.811947Z","end":"2026-03-02T02:11:38.057589Z","steps":["trace[1632729734] 'process raft request'  (duration: 112.019147ms)","trace[1632729734] 'compare'  (duration: 132.992533ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:38.33923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.655618ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635444858 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" value_size:665 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:11:38.339527Z","caller":"traceutil/trace.go:171","msg":"trace[2059622737] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"497.252939ms","start":"2026-03-02T02:11:37.842253Z","end":"2026-03-02T02:11:38.339505Z","steps":["trace[2059622737] 'process raft request'  (duration: 352.252513ms)","trace[2059622737] 'compare'  (duration: 144.522615ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:11:38.339589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:37.842231Z","time spent":"497.336022ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" value_size:665 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:11:38.339725Z","caller":"traceutil/trace.go:171","msg":"trace[363130140] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"497.143957ms","start":"2026-03-02T02:11:37.842571Z","end":"2026-03-02T02:11:38.339715Z","steps":["trace[363130140] 'process raft request'  (duration: 496.764808ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.339721Z","caller":"traceutil/trace.go:171","msg":"trace[2010817320] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"496.842429ms","start":"2026-03-02T02:11:37.842847Z","end":"2026-03-02T02:11:38.33969Z","steps":["trace[2010817320] 'process raft request'  (duration: 496.570273ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:38.339784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:37.842559Z","time spent":"497.192528ms","remote":"127.0.0.1:33184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":77330,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:866 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:77293 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:38.339852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:37.842838Z","time spent":"496.949713ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1292,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-769sp\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-769sp\" value_size:1204 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:11:38.499448Z","caller":"traceutil/trace.go:171","msg":"trace[1694963716] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"155.180166ms","start":"2026-03-02T02:11:38.344231Z","end":"2026-03-02T02:11:38.499411Z","steps":["trace[1694963716] 'process raft request'  (duration: 154.93328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.499394Z","caller":"traceutil/trace.go:171","msg":"trace[1348240575] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"155.637896ms","start":"2026-03-02T02:11:38.343709Z","end":"2026-03-02T02:11:38.499347Z","steps":["trace[1348240575] 'process raft request'  (duration: 109.346222ms)","trace[1348240575] 'compare'  (duration: 45.820413ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:38.499552Z","caller":"traceutil/trace.go:171","msg":"trace[2048539197] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"113.091411ms","start":"2026-03-02T02:11:38.38643Z","end":"2026-03-02T02:11:38.499521Z","steps":["trace[2048539197] 'process raft request'  (duration: 112.974718ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.499821Z","caller":"traceutil/trace.go:171","msg":"trace[81224796] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"116.285327ms","start":"2026-03-02T02:11:38.383523Z","end":"2026-03-02T02:11:38.499808Z","steps":["trace[81224796] 'process raft request'  (duration: 115.822156ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.499845Z","caller":"traceutil/trace.go:171","msg":"trace[244660987] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"116.505972ms","start":"2026-03-02T02:11:38.383316Z","end":"2026-03-02T02:11:38.499822Z","steps":["trace[244660987] 'process raft request'  (duration: 115.954949ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.499993Z","caller":"traceutil/trace.go:171","msg":"trace[330994769] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:909; }","duration":"130.282777ms","start":"2026-03-02T02:11:38.369666Z","end":"2026-03-02T02:11:38.499949Z","steps":["trace[330994769] 'read index received'  (duration: 10.039207ms)","trace[330994769] 'applied index is now lower than readState.Index'  (duration: 120.23945ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:38.50001Z","caller":"traceutil/trace.go:171","msg":"trace[903502494] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"155.083933ms","start":"2026-03-02T02:11:38.3449Z","end":"2026-03-02T02:11:38.499984Z","steps":["trace[903502494] 'process raft request'  (duration: 154.321065ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:38.500151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.461921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:11:38.500196Z","caller":"traceutil/trace.go:171","msg":"trace[12502761] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:878; }","duration":"130.560484ms","start":"2026-03-02T02:11:38.369624Z","end":"2026-03-02T02:11:38.500185Z","steps":["trace[12502761] 'agreement among raft nodes before linearized reading'  (duration: 130.40419ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.648323Z","caller":"traceutil/trace.go:171","msg":"trace[656521039] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"143.189684ms","start":"2026-03-02T02:11:38.505105Z","end":"2026-03-02T02:11:38.648294Z","steps":["trace[656521039] 'process raft request'  (duration: 104.152761ms)","trace[656521039] 'compare'  (duration: 38.861289ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:38.674951Z","caller":"traceutil/trace.go:171","msg":"trace[1516199401] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"148.015407ms","start":"2026-03-02T02:11:38.526887Z","end":"2026-03-02T02:11:38.674902Z","steps":["trace[1516199401] 'process raft request'  (duration: 147.956986ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.67519Z","caller":"traceutil/trace.go:171","msg":"trace[889117484] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"168.750447ms","start":"2026-03-02T02:11:38.506429Z","end":"2026-03-02T02:11:38.675179Z","steps":["trace[889117484] 'process raft request'  (duration: 168.223994ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.909478Z","caller":"traceutil/trace.go:171","msg":"trace[1905956197] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"108.373571ms","start":"2026-03-02T02:11:38.801085Z","end":"2026-03-02T02:11:38.909458Z","steps":["trace[1905956197] 'process raft request'  (duration: 108.173296ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.909762Z","caller":"traceutil/trace.go:171","msg":"trace[19229448] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"105.587145ms","start":"2026-03-02T02:11:38.804161Z","end":"2026-03-02T02:11:38.909748Z","steps":["trace[19229448] 'process raft request'  (duration: 105.252627ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.909803Z","caller":"traceutil/trace.go:171","msg":"trace[1753732346] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:930; }","duration":"100.267819ms","start":"2026-03-02T02:11:38.809509Z","end":"2026-03-02T02:11:38.909777Z","steps":["trace[1753732346] 'read index received'  (duration: 99.793008ms)","trace[1753732346] 'applied index is now lower than readState.Index'  (duration: 473.021µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:38.909957Z","caller":"traceutil/trace.go:171","msg":"trace[2043074421] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"101.922998ms","start":"2026-03-02T02:11:38.808011Z","end":"2026-03-02T02:11:38.909934Z","steps":["trace[2043074421] 'process raft request'  (duration: 101.623421ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:38.910054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.798345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:9373"}
{"level":"info","ts":"2026-03-02T02:11:38.910091Z","caller":"traceutil/trace.go:171","msg":"trace[1676452184] range","detail":"{range_begin:/registry/daemonsets/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:895; }","duration":"101.853416ms","start":"2026-03-02T02:11:38.808226Z","end":"2026-03-02T02:11:38.910079Z","steps":["trace[1676452184] 'agreement among raft nodes before linearized reading'  (duration: 101.681202ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:38.910208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.926312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:10872"}
{"level":"info","ts":"2026-03-02T02:11:38.910243Z","caller":"traceutil/trace.go:171","msg":"trace[1113791742] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:895; }","duration":"102.989123ms","start":"2026-03-02T02:11:38.807243Z","end":"2026-03-02T02:11:38.910232Z","steps":["trace[1113791742] 'agreement among raft nodes before linearized reading'  (duration: 102.84976ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:38.924713Z","caller":"traceutil/trace.go:171","msg":"trace[1359903203] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"108.887463ms","start":"2026-03-02T02:11:38.815776Z","end":"2026-03-02T02:11:38.924664Z","steps":["trace[1359903203] 'process raft request'  (duration: 108.514054ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:39.107589Z","caller":"traceutil/trace.go:171","msg":"trace[61692781] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"128.517377ms","start":"2026-03-02T02:11:38.979003Z","end":"2026-03-02T02:11:39.10752Z","steps":["trace[61692781] 'process raft request'  (duration: 128.299052ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:40.182677Z","caller":"traceutil/trace.go:171","msg":"trace[1755877207] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"116.747329ms","start":"2026-03-02T02:11:40.065902Z","end":"2026-03-02T02:11:40.182649Z","steps":["trace[1755877207] 'process raft request'  (duration: 116.553605ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:43.164137Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444937,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:11:43.665242Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635444937,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:11:43.706914Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.18749503s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-02T02:11:43.707306Z","caller":"traceutil/trace.go:171","msg":"trace[66198377] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"1.1879366s","start":"2026-03-02T02:11:42.519342Z","end":"2026-03-02T02:11:43.707279Z","steps":["trace[66198377] 'process raft request'  (duration: 1.187747406s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:43.70748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:42.519322Z","time spent":"1.188067304s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:911 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:44.791994Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.084914576s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-02T02:11:44.792334Z","caller":"traceutil/trace.go:171","msg":"trace[85833850] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"2.271369191s","start":"2026-03-02T02:11:42.520943Z","end":"2026-03-02T02:11:44.792313Z","steps":["trace[85833850] 'process raft request'  (duration: 2.27131137s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:42.520932Z","time spent":"2.271438073s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:909 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:11:44.792511Z","caller":"traceutil/trace.go:171","msg":"trace[1733300830] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:952; }","duration":"2.129214443s","start":"2026-03-02T02:11:42.663279Z","end":"2026-03-02T02:11:44.792493Z","steps":["trace[1733300830] 'read index received'  (duration: 1.043853666s)","trace[1733300830] 'applied index is now lower than readState.Index'  (duration: 1.085359647s)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:44.792557Z","caller":"traceutil/trace.go:171","msg":"trace[367553273] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"1.877490104s","start":"2026-03-02T02:11:42.915033Z","end":"2026-03-02T02:11:44.792523Z","steps":["trace[367553273] 'process raft request'  (duration: 1.877252619s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.521970804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:11:44.79271Z","caller":"traceutil/trace.go:171","msg":"trace[261664633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:917; }","duration":"1.522075347s","start":"2026-03-02T02:11:43.270624Z","end":"2026-03-02T02:11:44.792699Z","steps":["trace[261664633] 'agreement among raft nodes before linearized reading'  (duration: 1.521987104s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:42.91501Z","time spent":"1.877620987s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:839 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:44.79273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.129426477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:11:44.79278Z","caller":"traceutil/trace.go:171","msg":"trace[1150487426] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:917; }","duration":"2.12954516s","start":"2026-03-02T02:11:42.66322Z","end":"2026-03-02T02:11:44.792766Z","steps":["trace[1150487426] 'agreement among raft nodes before linearized reading'  (duration: 2.129376666s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.515548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-03-02T02:11:44.792812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.444452582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-02T02:11:44.792833Z","caller":"traceutil/trace.go:171","msg":"trace[557464580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:917; }","duration":"580.580529ms","start":"2026-03-02T02:11:44.212242Z","end":"2026-03-02T02:11:44.792823Z","steps":["trace[557464580] 'agreement among raft nodes before linearized reading'  (duration: 580.512028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:42.663199Z","time spent":"2.129618672s","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:11:44.792843Z","caller":"traceutil/trace.go:171","msg":"trace[892698383] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:917; }","duration":"1.444520004s","start":"2026-03-02T02:11:43.348315Z","end":"2026-03-02T02:11:44.792835Z","steps":["trace[892698383] 'agreement among raft nodes before linearized reading'  (duration: 1.444445942s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:44.212212Z","time spent":"580.63699ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-02T02:11:44.792869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:43.348299Z","time spent":"1.444562184s","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-03-02T02:11:44.792743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:43.270608Z","time spent":"1.522129307s","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:11:44.792945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.800179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-02T02:11:44.79297Z","caller":"traceutil/trace.go:171","msg":"trace[1031660361] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:917; }","duration":"317.861091ms","start":"2026-03-02T02:11:44.475102Z","end":"2026-03-02T02:11:44.792963Z","steps":["trace[1031660361] 'agreement among raft nodes before linearized reading'  (duration: 317.799579ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.792991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:44.475082Z","time spent":"317.903392ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.132\" "}
{"level":"info","ts":"2026-03-02T02:11:44.793187Z","caller":"traceutil/trace.go:171","msg":"trace[535872423] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"2.271956105s","start":"2026-03-02T02:11:42.520507Z","end":"2026-03-02T02:11:44.792463Z","steps":["trace[535872423] 'process raft request'  (duration: 2.271638487s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:44.79328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:42.520491Z","time spent":"2.272738384s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:910 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-02T02:11:47.865667Z","caller":"traceutil/trace.go:171","msg":"trace[748044184] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"100.886743ms","start":"2026-03-02T02:11:47.764756Z","end":"2026-03-02T02:11:47.865642Z","steps":["trace[748044184] 'process raft request'  (duration: 100.605927ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:59.326873Z","caller":"traceutil/trace.go:171","msg":"trace[524580027] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"350.042986ms","start":"2026-03-02T02:11:58.976804Z","end":"2026-03-02T02:11:59.326847Z","steps":["trace[524580027] 'read index received'  (duration: 349.890892ms)","trace[524580027] 'applied index is now lower than readState.Index'  (duration: 151.014µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:59.326944Z","caller":"traceutil/trace.go:171","msg":"trace[344802854] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"387.543479ms","start":"2026-03-02T02:11:58.939367Z","end":"2026-03-02T02:11:59.32691Z","steps":["trace[344802854] 'process raft request'  (duration: 387.331044ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:59.327107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.281881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-02T02:11:59.327149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:58.939347Z","time spent":"387.710034ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-02T02:11:59.327169Z","caller":"traceutil/trace.go:171","msg":"trace[1819595401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:956; }","duration":"350.355453ms","start":"2026-03-02T02:11:58.976799Z","end":"2026-03-02T02:11:59.327155Z","steps":["trace[1819595401] 'agreement among raft nodes before linearized reading'  (duration: 350.168669ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:59.327324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:58.976761Z","time spent":"350.529887ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-02T02:11:59.327366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.573265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:11:59.327445Z","caller":"traceutil/trace.go:171","msg":"trace[1619954095] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"328.688498ms","start":"2026-03-02T02:11:58.998739Z","end":"2026-03-02T02:11:59.327428Z","steps":["trace[1619954095] 'agreement among raft nodes before linearized reading'  (duration: 328.485084ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:59.327454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.164706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-02T02:11:59.327545Z","caller":"traceutil/trace.go:171","msg":"trace[887809765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:956; }","duration":"331.33085ms","start":"2026-03-02T02:11:58.996201Z","end":"2026-03-02T02:11:59.327532Z","steps":["trace[887809765] 'agreement among raft nodes before linearized reading'  (duration: 330.9279ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:59.327602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:58.996178Z","time spent":"331.414402ms","remote":"127.0.0.1:33404","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-03-02T02:11:59.327492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:58.998721Z","time spent":"328.76204ms","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:11:59.622481Z","caller":"traceutil/trace.go:171","msg":"trace[145000546] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"291.422611ms","start":"2026-03-02T02:11:59.331033Z","end":"2026-03-02T02:11:59.622456Z","steps":["trace[145000546] 'process raft request'  (duration: 291.295308ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:59.664597Z","caller":"traceutil/trace.go:171","msg":"trace[476828569] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:998; }","duration":"224.873899ms","start":"2026-03-02T02:11:59.439699Z","end":"2026-03-02T02:11:59.664573Z","steps":["trace[476828569] 'read index received'  (duration: 182.568134ms)","trace[476828569] 'applied index is now lower than readState.Index'  (duration: 42.304575ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:11:59.664653Z","caller":"traceutil/trace.go:171","msg":"trace[893702523] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"332.695122ms","start":"2026-03-02T02:11:59.331929Z","end":"2026-03-02T02:11:59.664625Z","steps":["trace[893702523] 'process raft request'  (duration: 332.477987ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:59.664763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.041453ms","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-03-02T02:11:59.664766Z","caller":"traceutil/trace.go:171","msg":"trace[1213240478] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"331.005702ms","start":"2026-03-02T02:11:59.333733Z","end":"2026-03-02T02:11:59.664739Z","steps":["trace[1213240478] 'process raft request'  (duration: 330.799468ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:11:59.664805Z","caller":"traceutil/trace.go:171","msg":"trace[1268135248] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:959; }","duration":"225.133126ms","start":"2026-03-02T02:11:59.439663Z","end":"2026-03-02T02:11:59.664796Z","steps":["trace[1268135248] 'agreement among raft nodes before linearized reading'  (duration: 225.002433ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:11:59.664907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:59.333717Z","time spent":"331.105774ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:11:59.665007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:59.331916Z","time spent":"332.927237ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:953 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:12:00.453553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635445070,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:12:02.668911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.04549017s","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635445071 > lease_revoke:<id:03909cac4f18b2d1>","response":"size:28"}
{"level":"info","ts":"2026-03-02T02:12:02.669009Z","caller":"traceutil/trace.go:171","msg":"trace[2146355023] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"2.716470473s","start":"2026-03-02T02:11:59.952521Z","end":"2026-03-02T02:12:02.668991Z","steps":["trace[2146355023] 'read index received'  (duration: 670.82819ms)","trace[2146355023] 'applied index is now lower than readState.Index'  (duration: 2.045641003s)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:02.669938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044172269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-02T02:12:02.669944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.400825561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:12:02.669986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.33856641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-02T02:12:02.67Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.717473166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-02T02:12:02.670065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001037454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-02T02:12:02.670085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.452851033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-02T02:12:02.670096Z","caller":"traceutil/trace.go:171","msg":"trace[359512125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:959; }","duration":"1.001103766s","start":"2026-03-02T02:12:01.668984Z","end":"2026-03-02T02:12:02.670088Z","steps":["trace[359512125] 'agreement among raft nodes before linearized reading'  (duration: 1.001022994s)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:02.670151Z","caller":"traceutil/trace.go:171","msg":"trace[239691487] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:959; }","duration":"1.452927134s","start":"2026-03-02T02:12:01.217187Z","end":"2026-03-02T02:12:02.670114Z","steps":["trace[239691487] 'agreement among raft nodes before linearized reading'  (duration: 1.452873473s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:02.670161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:01.668967Z","time spent":"1.001186817s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-02T02:12:02.670192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:01.217166Z","time spent":"1.453016846s","remote":"127.0.0.1:33402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"warn","ts":"2026-03-02T02:12:02.670197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.33861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:12:02.67018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000772867s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:12:02.670034Z","caller":"traceutil/trace.go:171","msg":"trace[829793607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:959; }","duration":"1.338649671s","start":"2026-03-02T02:12:01.331372Z","end":"2026-03-02T02:12:02.670022Z","steps":["trace[829793607] 'agreement among raft nodes before linearized reading'  (duration: 1.338533989s)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:02.67026Z","caller":"traceutil/trace.go:171","msg":"trace[433784866] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:959; }","duration":"1.00087751s","start":"2026-03-02T02:12:01.669361Z","end":"2026-03-02T02:12:02.670239Z","steps":["trace[433784866] 'agreement among raft nodes before linearized reading'  (duration: 1.000607464s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:02.670303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:01.669351Z","time spent":"1.000943652s","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:12:02.670107Z","caller":"traceutil/trace.go:171","msg":"trace[1119378450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:959; }","duration":"2.71761386s","start":"2026-03-02T02:11:59.952469Z","end":"2026-03-02T02:12:02.670083Z","steps":["trace[1119378450] 'agreement among raft nodes before linearized reading'  (duration: 2.717387704s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:02.670395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:11:59.952452Z","time spent":"2.717934967s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-02T02:12:02.670297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:01.331354Z","time spent":"1.338927088s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-02T02:12:02.669986Z","caller":"traceutil/trace.go:171","msg":"trace[2071409155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:959; }","duration":"1.044261251s","start":"2026-03-02T02:12:01.625713Z","end":"2026-03-02T02:12:02.669974Z","steps":["trace[2071409155] 'agreement among raft nodes before linearized reading'  (duration: 1.044107568s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:02.670478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:01.625694Z","time spent":"1.044778423s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-02T02:12:02.670034Z","caller":"traceutil/trace.go:171","msg":"trace[52469057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:959; }","duration":"1.400972034s","start":"2026-03-02T02:12:01.269043Z","end":"2026-03-02T02:12:02.670016Z","steps":["trace[52469057] 'agreement among raft nodes before linearized reading'  (duration: 1.40079905s)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:02.670496Z","caller":"traceutil/trace.go:171","msg":"trace[108179706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:959; }","duration":"140.78829ms","start":"2026-03-02T02:12:02.529442Z","end":"2026-03-02T02:12:02.67023Z","steps":["trace[108179706] 'agreement among raft nodes before linearized reading'  (duration: 140.321369ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:02.670545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:01.269026Z","time spent":"1.401510156s","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:12:02.670595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.427248424s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-02T02:12:02.670635Z","caller":"traceutil/trace.go:171","msg":"trace[902799703] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:959; }","duration":"2.427321686s","start":"2026-03-02T02:12:00.2433Z","end":"2026-03-02T02:12:02.670622Z","steps":["trace[902799703] 'agreement among raft nodes before linearized reading'  (duration: 2.426435346s)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:02.67088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:00.24328Z","time spent":"2.427546341s","remote":"127.0.0.1:33514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":53,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"info","ts":"2026-03-02T02:12:02.860051Z","caller":"traceutil/trace.go:171","msg":"trace[1246753500] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"183.897724ms","start":"2026-03-02T02:12:02.676127Z","end":"2026-03-02T02:12:02.860025Z","steps":["trace[1246753500] 'process raft request'  (duration: 183.759131ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:03.223378Z","caller":"traceutil/trace.go:171","msg":"trace[354095652] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"547.118588ms","start":"2026-03-02T02:12:02.676237Z","end":"2026-03-02T02:12:03.223355Z","steps":["trace[354095652] 'process raft request'  (duration: 547.050546ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:03.223524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:02.676209Z","time spent":"547.2432ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:12:03.223649Z","caller":"traceutil/trace.go:171","msg":"trace[2051225806] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"547.444355ms","start":"2026-03-02T02:12:02.676195Z","end":"2026-03-02T02:12:03.22364Z","steps":["trace[2051225806] 'process raft request'  (duration: 547.020855ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:03.223701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:02.676142Z","time spent":"547.533467ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:957 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-02T02:12:03.22377Z","caller":"traceutil/trace.go:171","msg":"trace[1413634361] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"547.531367ms","start":"2026-03-02T02:12:02.676231Z","end":"2026-03-02T02:12:03.223762Z","steps":["trace[1413634361] 'process raft request'  (duration: 547.028185ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:03.223817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:02.67621Z","time spent":"547.584408ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:958 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:12:03.223388Z","caller":"traceutil/trace.go:171","msg":"trace[2037283819] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"547.23146ms","start":"2026-03-02T02:12:02.676126Z","end":"2026-03-02T02:12:03.223357Z","steps":["trace[2037283819] 'process raft request'  (duration: 546.923793ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:03.223897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:02.676109Z","time spent":"547.768063ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:959 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:12:03.483996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.672709ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635445082 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e458c19c16a1\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e458c19c16a1\" value_size:745 lease:256877442635445080 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:12:03.484075Z","caller":"traceutil/trace.go:171","msg":"trace[781450842] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"218.345316ms","start":"2026-03-02T02:12:03.265716Z","end":"2026-03-02T02:12:03.484062Z","steps":["trace[781450842] 'process raft request'  (duration: 61.558664ms)","trace[781450842] 'compare'  (duration: 156.513725ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:04.877821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:04.477663Z","time spent":"400.153943ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-02T02:12:05.521507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.703655ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635445090 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.132\" mod_revision:943 > success:<request_put:<key:\"/registry/masterleases/199.204.45.132\" value_size:67 lease:256877442635445087 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.132\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:12:05.521629Z","caller":"traceutil/trace.go:171","msg":"trace[1365853674] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"642.660194ms","start":"2026-03-02T02:12:04.878951Z","end":"2026-03-02T02:12:05.521611Z","steps":["trace[1365853674] 'process raft request'  (duration: 284.766045ms)","trace[1365853674] 'compare'  (duration: 357.363776ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:05.521688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:04.878935Z","time spent":"642.725566ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.132\" mod_revision:943 > success:<request_put:<key:\"/registry/masterleases/199.204.45.132\" value_size:67 lease:256877442635445087 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.132\" > >"}
{"level":"info","ts":"2026-03-02T02:12:05.533667Z","caller":"traceutil/trace.go:171","msg":"trace[1892233186] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1011; }","duration":"304.894994ms","start":"2026-03-02T02:12:05.228751Z","end":"2026-03-02T02:12:05.533646Z","steps":["trace[1892233186] 'read index received'  (duration: 304.816062ms)","trace[1892233186] 'applied index is now lower than readState.Index'  (duration: 77.822µs)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:12:05.533765Z","caller":"traceutil/trace.go:171","msg":"trace[1216824548] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"651.92272ms","start":"2026-03-02T02:12:04.881827Z","end":"2026-03-02T02:12:05.53375Z","steps":["trace[1216824548] 'process raft request'  (duration: 651.699105ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:05.533879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:04.8818Z","time spent":"651.997762ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:960 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-02T02:12:05.53395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.188631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-02T02:12:05.534004Z","caller":"traceutil/trace.go:171","msg":"trace[1763370699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"305.270463ms","start":"2026-03-02T02:12:05.228721Z","end":"2026-03-02T02:12:05.533991Z","steps":["trace[1763370699] 'agreement among raft nodes before linearized reading'  (duration: 305.032027ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:05.534048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.228707Z","time spent":"305.330154ms","remote":"127.0.0.1:33404","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":"info","ts":"2026-03-02T02:12:05.982567Z","caller":"traceutil/trace.go:171","msg":"trace[860741819] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"448.811167ms","start":"2026-03-02T02:12:05.53373Z","end":"2026-03-02T02:12:05.982541Z","steps":["trace[860741819] 'read index received'  (duration: 350.169398ms)","trace[860741819] 'applied index is now lower than readState.Index'  (duration: 98.640599ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:05.982786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.010388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-02T02:12:05.982817Z","caller":"traceutil/trace.go:171","msg":"trace[1951325272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:968; }","duration":"754.07713ms","start":"2026-03-02T02:12:05.22873Z","end":"2026-03-02T02:12:05.982807Z","steps":["trace[1951325272] 'agreement among raft nodes before linearized reading'  (duration: 753.896846ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:05.982849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.228719Z","time spent":"754.122661ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-02T02:12:05.982863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.982653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-02T02:12:05.982933Z","caller":"traceutil/trace.go:171","msg":"trace[508869475] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:968; }","duration":"459.096486ms","start":"2026-03-02T02:12:05.523819Z","end":"2026-03-02T02:12:05.982916Z","steps":["trace[508869475] 'agreement among raft nodes before linearized reading'  (duration: 458.938233ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:05.982942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.562908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-02T02:12:05.982917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-02T02:12:05.982968Z","caller":"traceutil/trace.go:171","msg":"trace[306058371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"753.620138ms","start":"2026-03-02T02:12:05.229341Z","end":"2026-03-02T02:12:05.982961Z","steps":["trace[306058371] 'agreement among raft nodes before linearized reading'  (duration: 753.536176ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:05.982985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.229326Z","time spent":"753.65554ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-02T02:12:05.982979Z","caller":"traceutil/trace.go:171","msg":"trace[1457980520] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:968; }","duration":"751.167172ms","start":"2026-03-02T02:12:05.231801Z","end":"2026-03-02T02:12:05.982969Z","steps":["trace[1457980520] 'agreement among raft nodes before linearized reading'  (duration: 750.992708ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:05.982977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.523805Z","time spent":"459.163468ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"info","ts":"2026-03-02T02:12:05.982979Z","caller":"traceutil/trace.go:171","msg":"trace[462641791] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"614.376314ms","start":"2026-03-02T02:12:05.368579Z","end":"2026-03-02T02:12:05.982955Z","steps":["trace[462641791] 'process raft request'  (duration: 515.307616ms)","trace[462641791] 'compare'  (duration: 98.27956ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:05.983008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.231796Z","time spent":"751.207012ms","remote":"127.0.0.1:33404","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-03-02T02:12:05.983078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.368555Z","time spent":"614.466467ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:948 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-02T02:12:06.48471Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877442635445095,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-02T02:12:06.820074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.450855ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635445094 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:961 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:12:06.820198Z","caller":"traceutil/trace.go:171","msg":"trace[1072552040] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"1.28149626s","start":"2026-03-02T02:12:05.538678Z","end":"2026-03-02T02:12:06.820174Z","steps":["trace[1072552040] 'process raft request'  (duration: 955.881702ms)","trace[1072552040] 'compare'  (duration: 325.310041ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:06.820278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.538658Z","time spent":"1.281579682s","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:961 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:12:06.864851Z","caller":"traceutil/trace.go:171","msg":"trace[654399154] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"878.153123ms","start":"2026-03-02T02:12:05.986676Z","end":"2026-03-02T02:12:06.864829Z","steps":["trace[654399154] 'process raft request'  (duration: 877.967439ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:06.86499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.986664Z","time spent":"878.255395ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:963 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:12:06.865075Z","caller":"traceutil/trace.go:171","msg":"trace[89915709] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1013; }","duration":"880.429136ms","start":"2026-03-02T02:12:05.984626Z","end":"2026-03-02T02:12:06.865055Z","steps":["trace[89915709] 'read index received'  (duration: 509.942192ms)","trace[89915709] 'applied index is now lower than readState.Index'  (duration: 370.486144ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:12:06.865105Z","caller":"traceutil/trace.go:171","msg":"trace[380812110] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"878.244655ms","start":"2026-03-02T02:12:05.986832Z","end":"2026-03-02T02:12:06.865077Z","steps":["trace[380812110] 'process raft request'  (duration: 877.938188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:06.865131Z","caller":"traceutil/trace.go:171","msg":"trace[531749273] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"877.914298ms","start":"2026-03-02T02:12:05.987195Z","end":"2026-03-02T02:12:06.865109Z","steps":["trace[531749273] 'process raft request'  (duration: 877.759434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:06.865214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.489158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-02T02:12:06.865226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.59361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-02T02:12:06.865241Z","caller":"traceutil/trace.go:171","msg":"trace[6360084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"595.565968ms","start":"2026-03-02T02:12:06.269667Z","end":"2026-03-02T02:12:06.865233Z","steps":["trace[6360084] 'agreement among raft nodes before linearized reading'  (duration: 595.497007ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:06.865222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.987188Z","time spent":"877.987979ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:964 > 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-03-02T02:12:06.865239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.986827Z","time spent":"878.340977ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:962 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-02T02:12:06.865261Z","caller":"traceutil/trace.go:171","msg":"trace[955249164] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:972; }","duration":"880.638801ms","start":"2026-03-02T02:12:05.984612Z","end":"2026-03-02T02:12:06.865251Z","steps":["trace[955249164] 'agreement among raft nodes before linearized reading'  (duration: 880.529138ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:06.865435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:05.984602Z","time spent":"880.822385ms","remote":"127.0.0.1:33154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "}
{"level":"warn","ts":"2026-03-02T02:12:06.865267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:06.269648Z","time spent":"595.6136ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-02T02:12:08.010964Z","caller":"traceutil/trace.go:171","msg":"trace[709889179] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"160.365296ms","start":"2026-03-02T02:12:07.85056Z","end":"2026-03-02T02:12:08.010926Z","steps":["trace[709889179] 'process raft request'  (duration: 157.318625ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:08.609627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.045062ms","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-03-02T02:12:08.609786Z","caller":"traceutil/trace.go:171","msg":"trace[110439744] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:974; }","duration":"285.221536ms","start":"2026-03-02T02:12:08.324542Z","end":"2026-03-02T02:12:08.609764Z","steps":["trace[110439744] 'range keys from in-memory index tree'  (duration: 285.025592ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:08.60992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.891798ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635445107 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e459dc016134\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e459dc016134\" value_size:657 lease:256877442635445080 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:12:08.610769Z","caller":"traceutil/trace.go:171","msg":"trace[824052441] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1019; }","duration":"540.840663ms","start":"2026-03-02T02:12:08.069908Z","end":"2026-03-02T02:12:08.610749Z","steps":["trace[824052441] 'read index received'  (duration: 133.964242ms)","trace[824052441] 'applied index is now lower than readState.Index'  (duration: 406.874631ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:12:08.610771Z","caller":"traceutil/trace.go:171","msg":"trace[478067471] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"643.440063ms","start":"2026-03-02T02:12:07.967263Z","end":"2026-03-02T02:12:08.610703Z","steps":["trace[478067471] 'process raft request'  (duration: 236.666715ms)","trace[478067471] 'compare'  (duration: 405.677593ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:08.611028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:07.967243Z","time spent":"643.70968ms","remote":"127.0.0.1:33200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e459dc016134\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e459dc016134\" value_size:657 lease:256877442635445080 >> failure:<>"}
{"level":"warn","ts":"2026-03-02T02:12:08.611056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.653598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:12:08.611106Z","caller":"traceutil/trace.go:171","msg":"trace[1688996145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:975; }","duration":"340.75515ms","start":"2026-03-02T02:12:08.270335Z","end":"2026-03-02T02:12:08.611091Z","steps":["trace[1688996145] 'agreement among raft nodes before linearized reading'  (duration: 340.661278ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:08.611179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:08.270316Z","time spent":"340.853012ms","remote":"127.0.0.1:33106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:12:08.611209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.187691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5184"}
{"level":"info","ts":"2026-03-02T02:12:08.611265Z","caller":"traceutil/trace.go:171","msg":"trace[1050881708] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:975; }","duration":"541.381186ms","start":"2026-03-02T02:12:08.069868Z","end":"2026-03-02T02:12:08.61125Z","steps":["trace[1050881708] 'agreement among raft nodes before linearized reading'  (duration: 540.970366ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:08.611306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:08.069852Z","time spent":"541.443857ms","remote":"127.0.0.1:33298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5207,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-03-02T02:12:08.945968Z","caller":"traceutil/trace.go:171","msg":"trace[394569686] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"172.582031ms","start":"2026-03-02T02:12:08.773357Z","end":"2026-03-02T02:12:08.945939Z","steps":["trace[394569686] 'read index received'  (duration: 103.638255ms)","trace[394569686] 'applied index is now lower than readState.Index'  (duration: 68.942546ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:12:08.946039Z","caller":"traceutil/trace.go:171","msg":"trace[231440309] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"204.191717ms","start":"2026-03-02T02:12:08.741751Z","end":"2026-03-02T02:12:08.945943Z","steps":["trace[231440309] 'process raft request'  (duration: 135.352913ms)","trace[231440309] 'compare'  (duration: 68.68229ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:12:08.946217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.844147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:12:08.946293Z","caller":"traceutil/trace.go:171","msg":"trace[724816580] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:976; }","duration":"172.97118ms","start":"2026-03-02T02:12:08.773304Z","end":"2026-03-02T02:12:08.946275Z","steps":["trace[724816580] 'agreement among raft nodes before linearized reading'  (duration: 172.779935ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:08.946327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.435859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-02T02:12:08.946371Z","caller":"traceutil/trace.go:171","msg":"trace[1169754346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"121.533072ms","start":"2026-03-02T02:12:08.824826Z","end":"2026-03-02T02:12:08.946359Z","steps":["trace[1169754346] 'agreement among raft nodes before linearized reading'  (duration: 121.347637ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:09.323412Z","caller":"traceutil/trace.go:171","msg":"trace[2055585339] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"370.131414ms","start":"2026-03-02T02:12:08.953221Z","end":"2026-03-02T02:12:09.323353Z","steps":["trace[2055585339] 'process raft request'  (duration: 369.573051ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:09.323503Z","caller":"traceutil/trace.go:171","msg":"trace[535086086] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"370.033602ms","start":"2026-03-02T02:12:08.953445Z","end":"2026-03-02T02:12:09.323478Z","steps":["trace[535086086] 'process raft request'  (duration: 369.53685ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:09.323565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:08.953207Z","time spent":"370.298598ms","remote":"127.0.0.1:33200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":821,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e45a0a49e678\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-sdp85.1898e45a0a49e678\" value_size:728 lease:256877442635445080 >> failure:<>"}
{"level":"info","ts":"2026-03-02T02:12:09.323591Z","caller":"traceutil/trace.go:171","msg":"trace[1429687414] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"370.338659ms","start":"2026-03-02T02:12:08.953232Z","end":"2026-03-02T02:12:09.323571Z","steps":["trace[1429687414] 'process raft request'  (duration: 369.694194ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:09.323642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:08.953434Z","time spent":"370.126483ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:972 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-02T02:12:09.323728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:08.953208Z","time spent":"370.441101ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:969 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:12:09.324132Z","caller":"traceutil/trace.go:171","msg":"trace[1231174171] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"368.370303ms","start":"2026-03-02T02:12:08.955732Z","end":"2026-03-02T02:12:09.324102Z","steps":["trace[1231174171] 'process raft request'  (duration: 367.281188ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:12:09.324292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:12:08.955718Z","time spent":"368.479815ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:970 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-02T02:12:13.313005Z","caller":"traceutil/trace.go:171","msg":"trace[1378906675] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"282.305498ms","start":"2026-03-02T02:12:13.030673Z","end":"2026-03-02T02:12:13.312978Z","steps":["trace[1378906675] 'process raft request'  (duration: 282.074703ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:13.480274Z","caller":"traceutil/trace.go:171","msg":"trace[63494518] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"125.581347ms","start":"2026-03-02T02:12:13.354667Z","end":"2026-03-02T02:12:13.480248Z","steps":["trace[63494518] 'process raft request'  (duration: 124.932141ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:13.480839Z","caller":"traceutil/trace.go:171","msg":"trace[1221769292] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"128.823412ms","start":"2026-03-02T02:12:13.350792Z","end":"2026-03-02T02:12:13.479615Z","steps":["trace[1221769292] 'process raft request'  (duration: 117.820435ms)","trace[1221769292] 'compare'  (duration: 10.629048ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:12:13.48095Z","caller":"traceutil/trace.go:171","msg":"trace[2111454460] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"126.17969ms","start":"2026-03-02T02:12:13.354063Z","end":"2026-03-02T02:12:13.480243Z","steps":["trace[2111454460] 'process raft request'  (duration: 125.337661ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:15.957869Z","caller":"traceutil/trace.go:171","msg":"trace[1375749825] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"115.609654ms","start":"2026-03-02T02:12:15.842233Z","end":"2026-03-02T02:12:15.957843Z","steps":["trace[1375749825] 'process raft request'  (duration: 115.483901ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:16.15972Z","caller":"traceutil/trace.go:171","msg":"trace[1023929477] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"165.407484ms","start":"2026-03-02T02:12:15.994289Z","end":"2026-03-02T02:12:16.159697Z","steps":["trace[1023929477] 'process raft request'  (duration: 163.280044ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:17.651282Z","caller":"traceutil/trace.go:171","msg":"trace[1878516805] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"153.237581ms","start":"2026-03-02T02:12:17.498025Z","end":"2026-03-02T02:12:17.651263Z","steps":["trace[1878516805] 'process raft request'  (duration: 153.090247ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:12:17.651444Z","caller":"traceutil/trace.go:171","msg":"trace[1612341431] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"152.937353ms","start":"2026-03-02T02:12:17.498475Z","end":"2026-03-02T02:12:17.651413Z","steps":["trace[1612341431] 'process raft request'  (duration: 152.758459ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:13:04.338644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.377395ms","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-03-02T02:13:04.338754Z","caller":"traceutil/trace.go:171","msg":"trace[1413861361] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1248; }","duration":"209.515769ms","start":"2026-03-02T02:13:04.129215Z","end":"2026-03-02T02:13:04.338731Z","steps":["trace[1413861361] 'range keys from in-memory index tree'  (duration: 209.203811ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:13:18.179284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.902705ms","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-03-02T02:13:18.179359Z","caller":"traceutil/trace.go:171","msg":"trace[68565937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1304; }","duration":"116.021678ms","start":"2026-03-02T02:13:18.063318Z","end":"2026-03-02T02:13:18.179339Z","steps":["trace[68565937] 'range keys from in-memory index tree'  (duration: 115.70806ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:14:38.396593Z","caller":"traceutil/trace.go:171","msg":"trace[1867223844] transaction","detail":"{read_only:false; response_revision:1629; number_of_response:1; }","duration":"132.946652ms","start":"2026-03-02T02:14:38.263615Z","end":"2026-03-02T02:14:38.396562Z","steps":["trace[1867223844] 'process raft request'  (duration: 132.799269ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:14:38.72841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.863642ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635446722 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1621 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-02T02:14:38.728561Z","caller":"traceutil/trace.go:171","msg":"trace[984159728] transaction","detail":"{read_only:false; response_revision:1630; number_of_response:1; }","duration":"328.216702ms","start":"2026-03-02T02:14:38.400328Z","end":"2026-03-02T02:14:38.728545Z","steps":["trace[984159728] 'process raft request'  (duration: 165.155465ms)","trace[984159728] 'compare'  (duration: 162.737019ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:14:38.72863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:14:38.400315Z","time spent":"328.289733ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1621 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-02T02:14:38.72856Z","caller":"traceutil/trace.go:171","msg":"trace[1508111243] linearizableReadLoop","detail":"{readStateIndex:1705; appliedIndex:1704; }","duration":"222.762763ms","start":"2026-03-02T02:14:38.505737Z","end":"2026-03-02T02:14:38.728499Z","steps":["trace[1508111243] 'read index received'  (duration: 59.752907ms)","trace[1508111243] 'applied index is now lower than readState.Index'  (duration: 163.008806ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:14:38.72902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.291414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363686"}
{"level":"info","ts":"2026-03-02T02:14:38.729086Z","caller":"traceutil/trace.go:171","msg":"trace[1045771618] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:1630; }","duration":"223.377286ms","start":"2026-03-02T02:14:38.505674Z","end":"2026-03-02T02:14:38.729051Z","steps":["trace[1045771618] 'agreement among raft nodes before linearized reading'  (duration: 222.912496ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:14:38.919472Z","caller":"traceutil/trace.go:171","msg":"trace[1480868567] linearizableReadLoop","detail":"{readStateIndex:1706; appliedIndex:1705; }","duration":"138.164193ms","start":"2026-03-02T02:14:38.781282Z","end":"2026-03-02T02:14:38.919446Z","steps":["trace[1480868567] 'read index received'  (duration: 98.596581ms)","trace[1480868567] 'applied index is now lower than readState.Index'  (duration: 39.566672ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:14:38.919586Z","caller":"traceutil/trace.go:171","msg":"trace[8356997] transaction","detail":"{read_only:false; response_revision:1631; number_of_response:1; }","duration":"184.080171ms","start":"2026-03-02T02:14:38.735474Z","end":"2026-03-02T02:14:38.919554Z","steps":["trace[8356997] 'process raft request'  (duration: 144.412347ms)","trace[8356997] 'compare'  (duration: 39.454639ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:14:38.919707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.419619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-02T02:14:38.919777Z","caller":"traceutil/trace.go:171","msg":"trace[15752177] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1631; }","duration":"138.543592ms","start":"2026-03-02T02:14:38.781217Z","end":"2026-03-02T02:14:38.91976Z","steps":["trace[15752177] 'agreement among raft nodes before linearized reading'  (duration: 138.338807ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:15:13.343366Z","caller":"traceutil/trace.go:171","msg":"trace[1065589379] transaction","detail":"{read_only:false; response_revision:1788; number_of_response:1; }","duration":"103.852233ms","start":"2026-03-02T02:15:13.239486Z","end":"2026-03-02T02:15:13.343338Z","steps":["trace[1065589379] 'process raft request'  (duration: 103.73294ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:13.567388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.641766ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877442635447135 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:1780 > 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-03-02T02:15:13.567713Z","caller":"traceutil/trace.go:171","msg":"trace[962425616] transaction","detail":"{read_only:false; response_revision:1790; number_of_response:1; }","duration":"172.876481ms","start":"2026-03-02T02:15:13.394711Z","end":"2026-03-02T02:15:13.567587Z","steps":["trace[962425616] 'process raft request'  (duration: 53.897997ms)","trace[962425616] 'compare'  (duration: 118.518503ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:15:13.568279Z","caller":"traceutil/trace.go:171","msg":"trace[857856790] linearizableReadLoop","detail":"{readStateIndex:1874; appliedIndex:1872; }","duration":"142.58625ms","start":"2026-03-02T02:15:13.425667Z","end":"2026-03-02T02:15:13.568253Z","steps":["trace[857856790] 'read index received'  (duration: 22.911301ms)","trace[857856790] 'applied index is now lower than readState.Index'  (duration: 119.673669ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:15:13.568308Z","caller":"traceutil/trace.go:171","msg":"trace[625107061] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"143.923111ms","start":"2026-03-02T02:15:13.424359Z","end":"2026-03-02T02:15:13.568282Z","steps":["trace[625107061] 'process raft request'  (duration: 143.166923ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:13.568468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.466839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"}
{"level":"info","ts":"2026-03-02T02:15:13.568543Z","caller":"traceutil/trace.go:171","msg":"trace[1361742255] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1791; }","duration":"127.579702ms","start":"2026-03-02T02:15:13.440937Z","end":"2026-03-02T02:15:13.568516Z","steps":["trace[1361742255] 'agreement among raft nodes before linearized reading'  (duration: 127.443119ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:13.568586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.394889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"}
{"level":"info","ts":"2026-03-02T02:15:13.568684Z","caller":"traceutil/trace.go:171","msg":"trace[72935986] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1791; }","duration":"105.503941ms","start":"2026-03-02T02:15:13.463147Z","end":"2026-03-02T02:15:13.568651Z","steps":["trace[72935986] 'agreement among raft nodes before linearized reading'  (duration: 105.280516ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:13.569788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.108015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"}
{"level":"info","ts":"2026-03-02T02:15:13.569846Z","caller":"traceutil/trace.go:171","msg":"trace[44979633] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1791; }","duration":"144.187347ms","start":"2026-03-02T02:15:13.425644Z","end":"2026-03-02T02:15:13.569831Z","steps":["trace[44979633] 'agreement among raft nodes before linearized reading'  (duration: 142.677512ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.926229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.904876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-02T02:15:35.926307Z","caller":"traceutil/trace.go:171","msg":"trace[1962745735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1892; }","duration":"655.027129ms","start":"2026-03-02T02:15:35.271262Z","end":"2026-03-02T02:15:35.926289Z","steps":["trace[1962745735] 'range keys from in-memory index tree'  (duration: 654.822055ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.926347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:15:35.271242Z","time spent":"655.096091ms","remote":"127.0.0.1:33110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-02T02:15:35.926457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.409936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-02T02:15:35.926539Z","caller":"traceutil/trace.go:171","msg":"trace[969181613] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1892; }","duration":"648.523338ms","start":"2026-03-02T02:15:35.277996Z","end":"2026-03-02T02:15:35.92652Z","steps":["trace[969181613] 'range keys from in-memory index tree'  (duration: 648.12211ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.926579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:15:35.277985Z","time spent":"648.585591ms","remote":"127.0.0.1:33404","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-03-02T02:15:35.926678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.088331ms","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-03-02T02:15:35.926765Z","caller":"traceutil/trace.go:171","msg":"trace[1427939730] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1892; }","duration":"248.214025ms","start":"2026-03-02T02:15:35.678526Z","end":"2026-03-02T02:15:35.92674Z","steps":["trace[1427939730] 'range keys from in-memory index tree'  (duration: 247.441566ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.92696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.724252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-02T02:15:35.927794Z","caller":"traceutil/trace.go:171","msg":"trace[1371437144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1892; }","duration":"654.800904ms","start":"2026-03-02T02:15:35.272203Z","end":"2026-03-02T02:15:35.927004Z","steps":["trace[1371437144] 'range keys from in-memory index tree'  (duration: 653.889393ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.927866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:15:35.272192Z","time spent":"655.656704ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-02T02:15:35.928884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.574987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-02T02:15:35.928945Z","caller":"traceutil/trace.go:171","msg":"trace[731012002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1892; }","duration":"434.672239ms","start":"2026-03-02T02:15:35.49426Z","end":"2026-03-02T02:15:35.928932Z","steps":["trace[731012002] 'range keys from in-memory index tree'  (duration: 431.632589ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.928978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:15:35.494239Z","time spent":"434.727401ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-02T02:15:35.927038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.995774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-02T02:15:35.929269Z","caller":"traceutil/trace.go:171","msg":"trace[1168767093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1892; }","duration":"471.260197ms","start":"2026-03-02T02:15:35.457992Z","end":"2026-03-02T02:15:35.929253Z","steps":["trace[1168767093] 'range keys from in-memory index tree'  (duration: 468.023452ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:35.929322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:15:35.457965Z","time spent":"471.344308ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-02T02:15:36.074479Z","caller":"traceutil/trace.go:171","msg":"trace[901588509] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"143.631914ms","start":"2026-03-02T02:15:35.930813Z","end":"2026-03-02T02:15:36.074445Z","steps":["trace[901588509] 'process raft request'  (duration: 142.123109ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:15:36.074545Z","caller":"traceutil/trace.go:171","msg":"trace[472517997] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"140.272947ms","start":"2026-03-02T02:15:35.934249Z","end":"2026-03-02T02:15:36.074522Z","steps":["trace[472517997] 'process raft request'  (duration: 140.201465ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:15:36.074607Z","caller":"traceutil/trace.go:171","msg":"trace[575141604] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"140.42807ms","start":"2026-03-02T02:15:35.934144Z","end":"2026-03-02T02:15:36.074572Z","steps":["trace[575141604] 'process raft request'  (duration: 140.263036ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:15:36.075222Z","caller":"traceutil/trace.go:171","msg":"trace[1662107445] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"143.160633ms","start":"2026-03-02T02:15:35.931339Z","end":"2026-03-02T02:15:36.074499Z","steps":["trace[1662107445] 'process raft request'  (duration: 143.009079ms)"],"step_count":1}
{"level":"info","ts":"2026-03-02T02:15:44.626767Z","caller":"traceutil/trace.go:171","msg":"trace[205670684] linearizableReadLoop","detail":"{readStateIndex:2029; appliedIndex:2028; }","duration":"120.044808ms","start":"2026-03-02T02:15:44.506698Z","end":"2026-03-02T02:15:44.626743Z","steps":["trace[205670684] 'read index received'  (duration: 66.631612ms)","trace[205670684] 'applied index is now lower than readState.Index'  (duration: 53.412386ms)"],"step_count":2}
{"level":"info","ts":"2026-03-02T02:15:44.626785Z","caller":"traceutil/trace.go:171","msg":"trace[345119549] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"121.756658ms","start":"2026-03-02T02:15:44.504996Z","end":"2026-03-02T02:15:44.626753Z","steps":["trace[345119549] 'process raft request'  (duration: 68.327812ms)","trace[345119549] 'compare'  (duration: 53.264652ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-02T02:15:44.626956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.836688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"}
{"level":"info","ts":"2026-03-02T02:15:44.626987Z","caller":"traceutil/trace.go:171","msg":"trace[2037075323] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1938; }","duration":"111.90209ms","start":"2026-03-02T02:15:44.515076Z","end":"2026-03-02T02:15:44.626978Z","steps":["trace[2037075323] 'agreement among raft nodes before linearized reading'  (duration: 111.821318ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:15:44.626943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.228993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:693"}
{"level":"info","ts":"2026-03-02T02:15:44.627116Z","caller":"traceutil/trace.go:171","msg":"trace[1404726625] range","detail":"{range_begin:/registry/clusterroles/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1938; }","duration":"120.413297ms","start":"2026-03-02T02:15:44.50669Z","end":"2026-03-02T02:15:44.627103Z","steps":["trace[1404726625] 'agreement among raft nodes before linearized reading'  (duration: 120.179192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:16:08.761316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.291883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-02T02:16:08.76141Z","caller":"traceutil/trace.go:171","msg":"trace[670570845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2034; }","duration":"131.424627ms","start":"2026-03-02T02:16:08.629965Z","end":"2026-03-02T02:16:08.76139Z","steps":["trace[670570845] 'range keys from in-memory index tree'  (duration: 131.117119ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-02T02:16:08.761483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.235038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-02T02:16:08.761571Z","caller":"traceutil/trace.go:171","msg":"trace[825087984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2034; }","duration":"136.377521ms","start":"2026-03-02T02:16:08.625174Z","end":"2026-03-02T02:16:08.761552Z","steps":["trace[825087984] 'range keys from in-memory index tree'  (duration: 135.934001ms)"],"step_count":1}