{"level":"warn","ts":"2026-02-12T03:39:06.708023Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-12T03:39:06.708129Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-12T03:39:06.708187Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-12T03:39:06.708196Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-02-12T03:39:06.708214Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-12T03:39:06.713012Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]}
{"level":"info","ts":"2026-02-12T03:39:06.713105Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-12T03:39:06.71869Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.40173ms"}
{"level":"info","ts":"2026-02-12T03:39:06.770519Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"}
{"level":"info","ts":"2026-02-12T03:39:06.770692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-12T03:39:06.770773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"}
{"level":"info","ts":"2026-02-12T03:39:06.770787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-12T03:39:06.770797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"}
{"level":"info","ts":"2026-02-12T03:39:06.770961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"warn","ts":"2026-02-12T03:39:06.780281Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-12T03:39:06.78501Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-12T03:39:06.785982Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-12T03:39:06.790617Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-12T03:39:06.790736Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-12T03:39:06.790884Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-12T03:39:06.790909Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-12T03:39:06.791208Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-12T03:39:06.795104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"info","ts":"2026-02-12T03:39:06.808123Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-02-12T03:39:06.817001Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-12T03:39:06.817783Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-02-12T03:39:06.8178Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-02-12T03:39:06.819584Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-12T03:39:06.81961Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-12T03:39:07.471617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-12T03:39:07.471669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-12T03:39:07.471701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"}
{"level":"info","ts":"2026-02-12T03:39:07.471718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"}
{"level":"info","ts":"2026-02-12T03:39:07.471731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-02-12T03:39:07.471743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"}
{"level":"info","ts":"2026-02-12T03:39:07.471756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-02-12T03:39:07.472794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-12T03:39:07.473098Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:39:07.472767Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-12T03:39:07.473413Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-12T03:39:07.474396Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-12T03:39:07.474432Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-12T03:39:07.477473Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"}
{"level":"info","ts":"2026-02-12T03:39:07.477548Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:39:07.477661Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:39:07.477681Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T03:39:07.483286Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-12T03:39:23.070179Z","caller":"traceutil/trace.go:171","msg":"trace[844572281] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"382.836639ms","start":"2026-02-12T03:39:22.687317Z","end":"2026-02-12T03:39:23.070154Z","steps":["trace[844572281] 'process raft request'  (duration: 382.648315ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:39:23.070823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:22.6873Z","time spent":"382.967653ms","remote":"127.0.0.1:54724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4047,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:411 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4013 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-12T03:39:23.074898Z","caller":"traceutil/trace.go:171","msg":"trace[1061629232] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"301.690229ms","start":"2026-02-12T03:39:22.77319Z","end":"2026-02-12T03:39:23.07488Z","steps":["trace[1061629232] 'process raft request'  (duration: 301.559506ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:39:23.075136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:22.773172Z","time spent":"301.831143ms","remote":"127.0.0.1:54824","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:292 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-12T03:39:37.994208Z","caller":"traceutil/trace.go:171","msg":"trace[732705015] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"339.198653ms","start":"2026-02-12T03:39:37.654988Z","end":"2026-02-12T03:39:37.994187Z","steps":["trace[732705015] 'process raft request'  (duration: 339.029749ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:39:37.994448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:37.654974Z","time spent":"339.311915ms","remote":"127.0.0.1:54824","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:511 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-12T03:39:38.154558Z","caller":"traceutil/trace.go:171","msg":"trace[1386558287] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"499.403681ms","start":"2026-02-12T03:39:37.65514Z","end":"2026-02-12T03:39:38.154544Z","steps":["trace[1386558287] 'process raft request'  (duration: 405.751424ms)","trace[1386558287] 'compare'  (duration: 93.206687ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:39:38.154711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:37.655114Z","time spent":"499.511863ms","remote":"127.0.0.1:54824","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:510 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-12T03:39:38.15447Z","caller":"traceutil/trace.go:171","msg":"trace[1597264899] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"498.185091ms","start":"2026-02-12T03:39:37.656261Z","end":"2026-02-12T03:39:38.154447Z","steps":["trace[1597264899] 'read index received'  (duration: 338.089375ms)","trace[1597264899] 'applied index is now lower than readState.Index'  (duration: 160.094116ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:39:38.155456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.188385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:39:38.15564Z","caller":"traceutil/trace.go:171","msg":"trace[1829320754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"499.41246ms","start":"2026-02-12T03:39:37.656216Z","end":"2026-02-12T03:39:38.155629Z","steps":["trace[1829320754] 'agreement among raft nodes before linearized reading'  (duration: 499.205076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:39:38.155667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:37.656208Z","time spent":"499.451452ms","remote":"127.0.0.1:54576","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-02-12T03:39:38.155945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.695345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:39:38.155996Z","caller":"traceutil/trace.go:171","msg":"trace[1127075088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"377.786966ms","start":"2026-02-12T03:39:37.7782Z","end":"2026-02-12T03:39:38.155987Z","steps":["trace[1127075088] 'agreement among raft nodes before linearized reading'  (duration: 377.707034ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:39:38.156068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:37.778186Z","time spent":"377.843238ms","remote":"127.0.0.1:54824","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-02-12T03:39:42.414092Z","caller":"traceutil/trace.go:171","msg":"trace[1386251133] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"212.843323ms","start":"2026-02-12T03:39:42.201233Z","end":"2026-02-12T03:39:42.414076Z","steps":["trace[1386251133] 'read index received'  (duration: 212.746081ms)","trace[1386251133] 'applied index is now lower than readState.Index'  (duration: 96.722µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:39:42.414169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.927035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-12T03:39:42.414185Z","caller":"traceutil/trace.go:171","msg":"trace[1601735003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:526; }","duration":"212.969747ms","start":"2026-02-12T03:39:42.20121Z","end":"2026-02-12T03:39:42.414179Z","steps":["trace[1601735003] 'agreement among raft nodes before linearized reading'  (duration: 212.928966ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:39:42.414248Z","caller":"traceutil/trace.go:171","msg":"trace[1346085791] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"240.714008ms","start":"2026-02-12T03:39:42.17353Z","end":"2026-02-12T03:39:42.414244Z","steps":["trace[1346085791] 'process raft request'  (duration: 240.464792ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:39:42.879019Z","caller":"traceutil/trace.go:171","msg":"trace[337785250] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"225.376676ms","start":"2026-02-12T03:39:42.653623Z","end":"2026-02-12T03:39:42.879Z","steps":["trace[337785250] 'read index received'  (duration: 193.922804ms)","trace[337785250] 'applied index is now lower than readState.Index'  (duration: 31.453402ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:39:42.879089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.452287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:39:42.879105Z","caller":"traceutil/trace.go:171","msg":"trace[2055460638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"225.53293ms","start":"2026-02-12T03:39:42.653567Z","end":"2026-02-12T03:39:42.8791Z","steps":["trace[2055460638] 'agreement among raft nodes before linearized reading'  (duration: 225.489559ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:39:42.879206Z","caller":"traceutil/trace.go:171","msg":"trace[18288319] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"462.18592ms","start":"2026-02-12T03:39:42.417011Z","end":"2026-02-12T03:39:42.879197Z","steps":["trace[18288319] 'process raft request'  (duration: 430.581674ms)","trace[18288319] 'compare'  (duration: 31.331239ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:39:42.879273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:42.417Z","time spent":"462.22359ms","remote":"127.0.0.1:54824","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:522 > 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-02-12T03:39:43.598444Z","caller":"traceutil/trace.go:171","msg":"trace[345605157] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"155.161626ms","start":"2026-02-12T03:39:43.443239Z","end":"2026-02-12T03:39:43.598401Z","steps":["trace[345605157] 'process raft request'  (duration: 155.028823ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:39:45.963721Z","caller":"traceutil/trace.go:171","msg":"trace[427194173] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"232.198552ms","start":"2026-02-12T03:39:45.731505Z","end":"2026-02-12T03:39:45.963703Z","steps":["trace[427194173] 'process raft request'  (duration: 231.799733ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:39:45.969566Z","caller":"traceutil/trace.go:171","msg":"trace[846034140] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"131.191346ms","start":"2026-02-12T03:39:45.838355Z","end":"2026-02-12T03:39:45.969547Z","steps":["trace[846034140] 'process raft request'  (duration: 131.161855ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:39:45.971252Z","caller":"traceutil/trace.go:171","msg":"trace[1758238937] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"229.540587ms","start":"2026-02-12T03:39:45.741695Z","end":"2026-02-12T03:39:45.971236Z","steps":["trace[1758238937] 'process raft request'  (duration: 227.716262ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:39:49.030602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.63488ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101039853901835 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-vzk27.189362b085bb02ea\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-vzk27.189362b085bb02ea\" value_size:640 lease:4098729002999125109 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:39:49.030703Z","caller":"traceutil/trace.go:171","msg":"trace[634198463] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"244.344316ms","start":"2026-02-12T03:39:48.786346Z","end":"2026-02-12T03:39:49.03069Z","steps":["trace[634198463] 'process raft request'  (duration: 45.40127ms)","trace[634198463] 'compare'  (duration: 198.434124ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:39:49.035233Z","caller":"traceutil/trace.go:171","msg":"trace[176977579] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"166.011519ms","start":"2026-02-12T03:39:48.869215Z","end":"2026-02-12T03:39:49.035226Z","steps":["trace[176977579] 'process raft request'  (duration: 165.942277ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:00.615641Z","caller":"traceutil/trace.go:171","msg":"trace[626209282] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"113.718713ms","start":"2026-02-12T03:40:00.501898Z","end":"2026-02-12T03:40:00.615617Z","steps":["trace[626209282] 'process raft request'  (duration: 113.1926ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:03.901399Z","caller":"traceutil/trace.go:171","msg":"trace[1592569668] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"198.150477ms","start":"2026-02-12T03:40:03.703228Z","end":"2026-02-12T03:40:03.901378Z","steps":["trace[1592569668] 'process raft request'  (duration: 197.991243ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:04.408474Z","caller":"traceutil/trace.go:171","msg":"trace[1894114209] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"301.234622ms","start":"2026-02-12T03:40:04.107216Z","end":"2026-02-12T03:40:04.40845Z","steps":["trace[1894114209] 'process raft request'  (duration: 301.071408ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:04.40861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:04.107197Z","time spent":"301.344656ms","remote":"127.0.0.1:54824","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:713 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:05.104776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.648234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:40:05.104834Z","caller":"traceutil/trace.go:171","msg":"trace[769424962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:723; }","duration":"477.720475ms","start":"2026-02-12T03:40:04.627098Z","end":"2026-02-12T03:40:05.104818Z","steps":["trace[769424962] 'range keys from in-memory index tree'  (duration: 477.539131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:05.104863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:04.627056Z","time spent":"477.798637ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T03:40:05.612371Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902080,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T03:40:05.724684Z","caller":"traceutil/trace.go:171","msg":"trace[488485647] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:744; }","duration":"613.031702ms","start":"2026-02-12T03:40:05.111623Z","end":"2026-02-12T03:40:05.724655Z","steps":["trace[488485647] 'read index received'  (duration: 612.888179ms)","trace[488485647] 'applied index is now lower than readState.Index'  (duration: 142.863µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:05.724786Z","caller":"traceutil/trace.go:171","msg":"trace[503061582] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"616.892025ms","start":"2026-02-12T03:40:05.107886Z","end":"2026-02-12T03:40:05.724778Z","steps":["trace[503061582] 'process raft request'  (duration: 616.634879ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:05.724866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:05.107868Z","time spent":"616.937687ms","remote":"127.0.0.1:54824","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:714 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:05.725141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.506364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-12T03:40:05.725195Z","caller":"traceutil/trace.go:171","msg":"trace[931986866] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"613.589795ms","start":"2026-02-12T03:40:05.111589Z","end":"2026-02-12T03:40:05.725179Z","steps":["trace[931986866] 'agreement among raft nodes before linearized reading'  (duration: 613.467232ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:05.725237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:05.111575Z","time spent":"613.656507ms","remote":"127.0.0.1:54824","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-02-12T03:40:07.1429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.912983ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101039853902090 > lease_revoke:<id:38e19c4fee5a9851>","response":"size:28"}
{"level":"info","ts":"2026-02-12T03:40:07.14297Z","caller":"traceutil/trace.go:171","msg":"trace[2142784395] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"725.004082ms","start":"2026-02-12T03:40:06.417953Z","end":"2026-02-12T03:40:07.142957Z","steps":["trace[2142784395] 'read index received'  (duration: 258.023357ms)","trace[2142784395] 'applied index is now lower than readState.Index'  (duration: 466.979635ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:40:07.14323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.594834ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:07.143303Z","caller":"traceutil/trace.go:171","msg":"trace[573240703] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:727; }","duration":"223.675666ms","start":"2026-02-12T03:40:06.919616Z","end":"2026-02-12T03:40:07.143291Z","steps":["trace[573240703] 'range keys from in-memory index tree'  (duration: 223.582442ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:07.143346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.400312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-12T03:40:07.14337Z","caller":"traceutil/trace.go:171","msg":"trace[2130404485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:727; }","duration":"725.426292ms","start":"2026-02-12T03:40:06.417936Z","end":"2026-02-12T03:40:07.143362Z","steps":["trace[2130404485] 'agreement among raft nodes before linearized reading'  (duration: 725.308379ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:07.143391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:06.417865Z","time spent":"725.521515ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-12T03:40:07.14353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.09096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:07.143554Z","caller":"traceutil/trace.go:171","msg":"trace[994624864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"489.141422ms","start":"2026-02-12T03:40:06.654406Z","end":"2026-02-12T03:40:07.143547Z","steps":["trace[994624864] 'agreement among raft nodes before linearized reading'  (duration: 489.107321ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:07.143573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:06.654391Z","time spent":"489.178112ms","remote":"127.0.0.1:54576","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-02-12T03:40:07.255302Z","caller":"traceutil/trace.go:171","msg":"trace[747236730] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"107.689048ms","start":"2026-02-12T03:40:07.147593Z","end":"2026-02-12T03:40:07.255282Z","steps":["trace[747236730] 'process raft request'  (duration: 107.563595ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:11.865899Z","caller":"traceutil/trace.go:171","msg":"trace[743977735] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"114.811249ms","start":"2026-02-12T03:40:11.751074Z","end":"2026-02-12T03:40:11.865885Z","steps":["trace[743977735] 'read index received'  (duration: 114.693777ms)","trace[743977735] 'applied index is now lower than readState.Index'  (duration: 115.552µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:11.866077Z","caller":"traceutil/trace.go:171","msg":"trace[1824949037] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"120.18371ms","start":"2026-02-12T03:40:11.745885Z","end":"2026-02-12T03:40:11.866068Z","steps":["trace[1824949037] 'process raft request'  (duration: 119.915063ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:11.866237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.143448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:40:11.866265Z","caller":"traceutil/trace.go:171","msg":"trace[821462713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:746; }","duration":"115.20108ms","start":"2026-02-12T03:40:11.751056Z","end":"2026-02-12T03:40:11.866257Z","steps":["trace[821462713] 'agreement among raft nodes before linearized reading'  (duration: 115.111987ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:13.864338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.066761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:13.864419Z","caller":"traceutil/trace.go:171","msg":"trace[1103055632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"209.187174ms","start":"2026-02-12T03:40:13.655205Z","end":"2026-02-12T03:40:13.864392Z","steps":["trace[1103055632] 'range keys from in-memory index tree'  (duration: 209.0133ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:25.773225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.59306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:25.773286Z","caller":"traceutil/trace.go:171","msg":"trace[1891091230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"118.709173ms","start":"2026-02-12T03:40:25.654562Z","end":"2026-02-12T03:40:25.773271Z","steps":["trace[1891091230] 'range keys from in-memory index tree'  (duration: 118.536569ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:27.806672Z","caller":"traceutil/trace.go:171","msg":"trace[66869954] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"315.612851ms","start":"2026-02-12T03:40:27.491037Z","end":"2026-02-12T03:40:27.80665Z","steps":["trace[66869954] 'read index received'  (duration: 315.518069ms)","trace[66869954] 'applied index is now lower than readState.Index'  (duration: 93.962µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:27.806761Z","caller":"traceutil/trace.go:171","msg":"trace[616449327] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"323.165504ms","start":"2026-02-12T03:40:27.483587Z","end":"2026-02-12T03:40:27.806752Z","steps":["trace[616449327] 'process raft request'  (duration: 322.938259ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:27.80684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:27.483556Z","time spent":"323.224165ms","remote":"127.0.0.1:54824","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:785 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:27.806943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.901968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:27.80698Z","caller":"traceutil/trace.go:171","msg":"trace[1079853242] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:790; }","duration":"315.962959ms","start":"2026-02-12T03:40:27.49101Z","end":"2026-02-12T03:40:27.806973Z","steps":["trace[1079853242] 'agreement among raft nodes before linearized reading'  (duration: 315.910128ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:27.807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:27.490999Z","time spent":"315.9955ms","remote":"127.0.0.1:54804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:40:27.807126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.535034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:27.80719Z","caller":"traceutil/trace.go:171","msg":"trace[1060116831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"150.662277ms","start":"2026-02-12T03:40:27.656511Z","end":"2026-02-12T03:40:27.807173Z","steps":["trace[1060116831] 'agreement among raft nodes before linearized reading'  (duration: 150.574405ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:28.139222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.880874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:40:28.139318Z","caller":"traceutil/trace.go:171","msg":"trace[1372106532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"201.029507ms","start":"2026-02-12T03:40:27.938268Z","end":"2026-02-12T03:40:28.139297Z","steps":["trace[1372106532] 'range keys from in-memory index tree'  (duration: 200.730399ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:28.139506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.938587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:40:28.139537Z","caller":"traceutil/trace.go:171","msg":"trace[1701281728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:790; }","duration":"177.991529ms","start":"2026-02-12T03:40:27.961532Z","end":"2026-02-12T03:40:28.139524Z","steps":["trace[1701281728] 'range keys from in-memory index tree'  (duration: 177.726832ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:28.139637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.404546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:40:28.139665Z","caller":"traceutil/trace.go:171","msg":"trace[104330650] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:790; }","duration":"175.483868ms","start":"2026-02-12T03:40:27.96417Z","end":"2026-02-12T03:40:28.139654Z","steps":["trace[104330650] 'count revisions from in-memory index tree'  (duration: 175.308864ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:28.387908Z","caller":"traceutil/trace.go:171","msg":"trace[1480771006] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"239.466517ms","start":"2026-02-12T03:40:28.148419Z","end":"2026-02-12T03:40:28.387886Z","steps":["trace[1480771006] 'process raft request'  (duration: 239.306434ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:28.388106Z","caller":"traceutil/trace.go:171","msg":"trace[1844477089] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"237.885209ms","start":"2026-02-12T03:40:28.150211Z","end":"2026-02-12T03:40:28.388097Z","steps":["trace[1844477089] 'process raft request'  (duration: 237.644883ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:28.388248Z","caller":"traceutil/trace.go:171","msg":"trace[623312628] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"236.675659ms","start":"2026-02-12T03:40:28.151566Z","end":"2026-02-12T03:40:28.388242Z","steps":["trace[623312628] 'process raft request'  (duration: 236.505764ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:38.942128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902454,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T03:40:38.96654Z","caller":"traceutil/trace.go:171","msg":"trace[1091646399] linearizableReadLoop","detail":"{readStateIndex:902; appliedIndex:901; }","duration":"524.934839ms","start":"2026-02-12T03:40:38.441587Z","end":"2026-02-12T03:40:38.966522Z","steps":["trace[1091646399] 'read index received'  (duration: 524.756435ms)","trace[1091646399] 'applied index is now lower than readState.Index'  (duration: 177.634µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:38.966761Z","caller":"traceutil/trace.go:171","msg":"trace[364503813] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"528.892013ms","start":"2026-02-12T03:40:38.437859Z","end":"2026-02-12T03:40:38.966751Z","steps":["trace[364503813] 'process raft request'  (duration: 528.562735ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:38.966852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:38.437846Z","time spent":"528.933434ms","remote":"127.0.0.1:54824","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:816 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:38.967034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.157422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:38.967079Z","caller":"traceutil/trace.go:171","msg":"trace[1806833572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:872; }","duration":"311.248134ms","start":"2026-02-12T03:40:38.655816Z","end":"2026-02-12T03:40:38.967064Z","steps":["trace[1806833572] 'agreement among raft nodes before linearized reading'  (duration: 311.148622ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:38.967109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:38.655803Z","time spent":"311.300635ms","remote":"127.0.0.1:54576","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-02-12T03:40:38.967158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.569234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:40:38.967216Z","caller":"traceutil/trace.go:171","msg":"trace[1729863680] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:872; }","duration":"525.649636ms","start":"2026-02-12T03:40:38.441557Z","end":"2026-02-12T03:40:38.967206Z","steps":["trace[1729863680] 'agreement among raft nodes before linearized reading'  (duration: 525.530223ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:38.967237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:38.441547Z","time spent":"525.685147ms","remote":"127.0.0.1:54824","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-02-12T03:40:40.637434Z","caller":"traceutil/trace.go:171","msg":"trace[2061563755] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"205.666543ms","start":"2026-02-12T03:40:40.431751Z","end":"2026-02-12T03:40:40.637418Z","steps":["trace[2061563755] 'process raft request'  (duration: 205.56929ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:41.134394Z","caller":"traceutil/trace.go:171","msg":"trace[1570436721] linearizableReadLoop","detail":"{readStateIndex:907; appliedIndex:906; }","duration":"164.348931ms","start":"2026-02-12T03:40:40.970029Z","end":"2026-02-12T03:40:41.134378Z","steps":["trace[1570436721] 'read index received'  (duration: 164.209378ms)","trace[1570436721] 'applied index is now lower than readState.Index'  (duration: 138.833µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:40:41.13477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.71631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:40:41.134792Z","caller":"traceutil/trace.go:171","msg":"trace[480577184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:876; }","duration":"164.784432ms","start":"2026-02-12T03:40:40.970001Z","end":"2026-02-12T03:40:41.134785Z","steps":["trace[480577184] 'agreement among raft nodes before linearized reading'  (duration: 164.67929ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:41.134933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.656847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:40:41.13495Z","caller":"traceutil/trace.go:171","msg":"trace[1963854239] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:876; }","duration":"156.699438ms","start":"2026-02-12T03:40:40.978244Z","end":"2026-02-12T03:40:41.134944Z","steps":["trace[1963854239] 'agreement among raft nodes before linearized reading'  (duration: 156.641807ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:41.615023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.213594ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101039853902475 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.57\" mod_revision:800 > success:<request_put:<key:\"/registry/masterleases/199.204.45.57\" value_size:66 lease:4098729002999126663 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.57\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:40:41.61509Z","caller":"traceutil/trace.go:171","msg":"trace[732090627] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"478.817893ms","start":"2026-02-12T03:40:41.136259Z","end":"2026-02-12T03:40:41.615077Z","steps":["trace[732090627] 'process raft request'  (duration: 114.503356ms)","trace[732090627] 'compare'  (duration: 364.145813ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:40:41.61512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.136246Z","time spent":"478.860994ms","remote":"127.0.0.1:54604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.57\" mod_revision:800 > success:<request_put:<key:\"/registry/masterleases/199.204.45.57\" value_size:66 lease:4098729002999126663 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.57\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:42.25715Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.006406195s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-12T03:40:42.75954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.168603ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101039853902476 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:873 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:40:42.75966Z","caller":"traceutil/trace.go:171","msg":"trace[1355136957] linearizableReadLoop","detail":"{readStateIndex:910; appliedIndex:907; }","duration":"1.509358206s","start":"2026-02-12T03:40:41.25029Z","end":"2026-02-12T03:40:42.759648Z","steps":["trace[1355136957] 'read index received'  (duration: 476.811µs)","trace[1355136957] 'applied index is now lower than readState.Index'  (duration: 1.508880735s)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:42.759812Z","caller":"traceutil/trace.go:171","msg":"trace[598916603] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"1.619890508s","start":"2026-02-12T03:40:41.139914Z","end":"2026-02-12T03:40:42.759804Z","steps":["trace[598916603] 'process raft request'  (duration: 1.117398997s)","trace[598916603] 'compare'  (duration: 501.820454ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:40:42.759855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.1399Z","time spent":"1.619931588s","remote":"127.0.0.1:54824","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:873 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-12T03:40:42.759971Z","caller":"traceutil/trace.go:171","msg":"trace[1399470521] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"1.620006481s","start":"2026-02-12T03:40:41.139958Z","end":"2026-02-12T03:40:42.759965Z","steps":["trace[1399470521] 'process raft request'  (duration: 1.619648072s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.760002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.139954Z","time spent":"1.620031031s","remote":"127.0.0.1:54824","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:872 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:42.760109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.509821878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:42.760131Z","caller":"traceutil/trace.go:171","msg":"trace[774239366] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:879; }","duration":"1.50987856s","start":"2026-02-12T03:40:41.250245Z","end":"2026-02-12T03:40:42.760123Z","steps":["trace[774239366] 'agreement among raft nodes before linearized reading'  (duration: 1.509841709s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.760149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.25023Z","time spent":"1.50991419s","remote":"127.0.0.1:55086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:40:42.79951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183187235s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-02-12T03:40:42.799563Z","caller":"traceutil/trace.go:171","msg":"trace[292879745] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:880; }","duration":"1.183267026s","start":"2026-02-12T03:40:41.616283Z","end":"2026-02-12T03:40:42.79955Z","steps":["trace[292879745] 'agreement among raft nodes before linearized reading'  (duration: 1.183138813s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.799586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.531557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:42.799641Z","caller":"traceutil/trace.go:171","msg":"trace[365959908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:880; }","duration":"144.66555ms","start":"2026-02-12T03:40:42.654963Z","end":"2026-02-12T03:40:42.799629Z","steps":["trace[365959908] 'agreement among raft nodes before linearized reading'  (duration: 144.487366ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.79967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.259866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-12T03:40:42.799685Z","caller":"traceutil/trace.go:171","msg":"trace[1320260206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:880; }","duration":"158.317558ms","start":"2026-02-12T03:40:42.641363Z","end":"2026-02-12T03:40:42.799681Z","steps":["trace[1320260206] 'agreement among raft nodes before linearized reading'  (duration: 158.257676ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.799877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.301611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:40:42.799889Z","caller":"traceutil/trace.go:171","msg":"trace[1588597038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:880; }","duration":"521.316292ms","start":"2026-02-12T03:40:42.278569Z","end":"2026-02-12T03:40:42.799885Z","steps":["trace[1588597038] 'agreement among raft nodes before linearized reading'  (duration: 521.276802ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:42.79989Z","caller":"traceutil/trace.go:171","msg":"trace[473579699] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"1.444512761s","start":"2026-02-12T03:40:41.355368Z","end":"2026-02-12T03:40:42.799881Z","steps":["trace[473579699] 'process raft request'  (duration: 1.443950969s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.799902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:42.27852Z","time spent":"521.379213ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:40:42.799946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.355352Z","time spent":"1.444554672s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:801 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:42.799986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.23991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:40:42.799999Z","caller":"traceutil/trace.go:171","msg":"trace[1113718402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:880; }","duration":"928.278821ms","start":"2026-02-12T03:40:41.871716Z","end":"2026-02-12T03:40:42.799995Z","steps":["trace[1113718402] 'agreement among raft nodes before linearized reading'  (duration: 928.24011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.799603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.616274Z","time spent":"1.183317468s","remote":"127.0.0.1:54716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-12T03:40:42.800011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:41.871689Z","time spent":"928.318712ms","remote":"127.0.0.1:54824","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-02-12T03:40:42.954435Z","caller":"traceutil/trace.go:171","msg":"trace[799184582] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"149.604007ms","start":"2026-02-12T03:40:42.804816Z","end":"2026-02-12T03:40:42.95442Z","steps":["trace[799184582] 'read index received'  (duration: 140.041668ms)","trace[799184582] 'applied index is now lower than readState.Index'  (duration: 9.561499ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:42.954462Z","caller":"traceutil/trace.go:171","msg":"trace[1234020673] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"151.049701ms","start":"2026-02-12T03:40:42.80339Z","end":"2026-02-12T03:40:42.954439Z","steps":["trace[1234020673] 'process raft request'  (duration: 141.38609ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:42.954526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.697659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-12T03:40:42.954545Z","caller":"traceutil/trace.go:171","msg":"trace[1320938248] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:881; }","duration":"149.7484ms","start":"2026-02-12T03:40:42.804791Z","end":"2026-02-12T03:40:42.95454Z","steps":["trace[1320938248] 'agreement among raft nodes before linearized reading'  (duration: 149.681678ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:42.96196Z","caller":"traceutil/trace.go:171","msg":"trace[2043918301] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"155.337235ms","start":"2026-02-12T03:40:42.80661Z","end":"2026-02-12T03:40:42.961948Z","steps":["trace[2043918301] 'process raft request'  (duration: 155.308745ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:42.962072Z","caller":"traceutil/trace.go:171","msg":"trace[2048603019] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"157.194899ms","start":"2026-02-12T03:40:42.804865Z","end":"2026-02-12T03:40:42.96206Z","steps":["trace[2048603019] 'process raft request'  (duration: 156.937833ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:44.969501Z","caller":"traceutil/trace.go:171","msg":"trace[287551883] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:914; }","duration":"195.444708ms","start":"2026-02-12T03:40:44.774045Z","end":"2026-02-12T03:40:44.96949Z","steps":["trace[287551883] 'read index received'  (duration: 195.326725ms)","trace[287551883] 'applied index is now lower than readState.Index'  (duration: 117.533µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:44.969678Z","caller":"traceutil/trace.go:171","msg":"trace[100558986] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"215.709184ms","start":"2026-02-12T03:40:44.753963Z","end":"2026-02-12T03:40:44.969673Z","steps":["trace[100558986] 'process raft request'  (duration: 215.438128ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:44.969814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.758435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:40:44.969831Z","caller":"traceutil/trace.go:171","msg":"trace[1371292691] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:884; }","duration":"195.800886ms","start":"2026-02-12T03:40:44.774025Z","end":"2026-02-12T03:40:44.969826Z","steps":["trace[1371292691] 'agreement among raft nodes before linearized reading'  (duration: 195.737445ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:44.96994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.867007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:40:44.969955Z","caller":"traceutil/trace.go:171","msg":"trace[464067536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:884; }","duration":"195.887728ms","start":"2026-02-12T03:40:44.774062Z","end":"2026-02-12T03:40:44.96995Z","steps":["trace[464067536] 'agreement among raft nodes before linearized reading'  (duration: 195.849427ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:47.48164Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902504,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:40:47.98193Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902504,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:40:48.482563Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902504,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:40:48.985013Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902504,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:40:49.485215Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853902504,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:40:49.610904Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.629752228s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T03:40:49.611249Z","caller":"traceutil/trace.go:171","msg":"trace[773303317] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"2.630156806s","start":"2026-02-12T03:40:46.981075Z","end":"2026-02-12T03:40:49.611232Z","steps":["trace[773303317] 'process raft request'  (duration: 2.630040134s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.611342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:46.981067Z","time spent":"2.630221718s","remote":"127.0.0.1:54824","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:885 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-12T03:40:49.652134Z","caller":"traceutil/trace.go:171","msg":"trace[1360270377] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"2.666953068s","start":"2026-02-12T03:40:46.985173Z","end":"2026-02-12T03:40:49.652126Z","steps":["trace[1360270377] 'process raft request'  (duration: 2.66578512s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.65224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:46.985164Z","time spent":"2.667024361s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:886 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-12T03:40:49.653386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.672186825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:40:49.653415Z","caller":"traceutil/trace.go:171","msg":"trace[481885846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:891; }","duration":"2.672226496s","start":"2026-02-12T03:40:46.98118Z","end":"2026-02-12T03:40:49.653406Z","steps":["trace[481885846] 'agreement among raft nodes before linearized reading'  (duration: 2.672112503s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.653437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:46.981177Z","time spent":"2.672255256s","remote":"127.0.0.1:54824","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-02-12T03:40:49.651898Z","caller":"traceutil/trace.go:171","msg":"trace[211091277] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"2.670690829s","start":"2026-02-12T03:40:46.981189Z","end":"2026-02-12T03:40:49.651879Z","steps":["trace[211091277] 'read index received'  (duration: 2.630483785s)","trace[211091277] 'applied index is now lower than readState.Index'  (duration: 40.206174ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:40:49.654469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.682940232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:49.654493Z","caller":"traceutil/trace.go:171","msg":"trace[682435068] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:891; }","duration":"1.683007674s","start":"2026-02-12T03:40:47.971478Z","end":"2026-02-12T03:40:49.654486Z","steps":["trace[682435068] 'agreement among raft nodes before linearized reading'  (duration: 1.682966073s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.654511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:47.971457Z","time spent":"1.683049005s","remote":"127.0.0.1:55040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T03:40:49.654836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.998459928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:40:49.65487Z","caller":"traceutil/trace.go:171","msg":"trace[362317912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:891; }","duration":"1.99853536s","start":"2026-02-12T03:40:47.656327Z","end":"2026-02-12T03:40:49.654862Z","steps":["trace[362317912] 'agreement among raft nodes before linearized reading'  (duration: 1.998480089s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.654892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:47.656308Z","time spent":"1.998579362s","remote":"127.0.0.1:54576","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-02-12T03:40:49.659244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.667807909s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:40:49.659274Z","caller":"traceutil/trace.go:171","msg":"trace[1665139706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:892; }","duration":"2.66784558s","start":"2026-02-12T03:40:46.991419Z","end":"2026-02-12T03:40:49.659265Z","steps":["trace[1665139706] 'agreement among raft nodes before linearized reading'  (duration: 2.667778228s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.65929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:46.991403Z","time spent":"2.667883862s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T03:40:49.657927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.667573754s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:40:49.665496Z","caller":"traceutil/trace.go:171","msg":"trace[56817300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:891; }","duration":"2.675161985s","start":"2026-02-12T03:40:46.990323Z","end":"2026-02-12T03:40:49.665485Z","steps":["trace[56817300] 'agreement among raft nodes before linearized reading'  (duration: 2.667496512s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:49.665538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:46.990317Z","time spent":"2.675197066s","remote":"127.0.0.1:54824","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-02-12T03:40:55.746564Z","caller":"traceutil/trace.go:171","msg":"trace[1723522366] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:939; }","duration":"116.899133ms","start":"2026-02-12T03:40:55.629647Z","end":"2026-02-12T03:40:55.746546Z","steps":["trace[1723522366] 'read index received'  (duration: 116.777801ms)","trace[1723522366] 'applied index is now lower than readState.Index'  (duration: 120.742µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:40:55.746786Z","caller":"traceutil/trace.go:171","msg":"trace[759051298] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"535.522963ms","start":"2026-02-12T03:40:55.211255Z","end":"2026-02-12T03:40:55.746778Z","steps":["trace[759051298] 'process raft request'  (duration: 535.183395ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:40:55.746856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:40:55.211239Z","time spent":"535.569674ms","remote":"127.0.0.1:54824","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:884 > 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-02-12T03:40:55.747032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.389515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T03:40:55.74707Z","caller":"traceutil/trace.go:171","msg":"trace[887990100] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:907; }","duration":"117.427106ms","start":"2026-02-12T03:40:55.629637Z","end":"2026-02-12T03:40:55.747064Z","steps":["trace[887990100] 'agreement among raft nodes before linearized reading'  (duration: 117.331194ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:55.902132Z","caller":"traceutil/trace.go:171","msg":"trace[1108291697] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"148.412349ms","start":"2026-02-12T03:40:55.753705Z","end":"2026-02-12T03:40:55.902117Z","steps":["trace[1108291697] 'process raft request'  (duration: 148.390398ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:55.902394Z","caller":"traceutil/trace.go:171","msg":"trace[239119554] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"148.682795ms","start":"2026-02-12T03:40:55.753705Z","end":"2026-02-12T03:40:55.902388Z","steps":["trace[239119554] 'process raft request'  (duration: 148.304246ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:56.047211Z","caller":"traceutil/trace.go:171","msg":"trace[1439360795] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"290.262551ms","start":"2026-02-12T03:40:55.756933Z","end":"2026-02-12T03:40:56.047196Z","steps":["trace[1439360795] 'process raft request'  (duration: 290.235581ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:56.047479Z","caller":"traceutil/trace.go:171","msg":"trace[1139845472] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"293.714684ms","start":"2026-02-12T03:40:55.75374Z","end":"2026-02-12T03:40:56.047454Z","steps":["trace[1139845472] 'process raft request'  (duration: 291.88639ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:40:56.047572Z","caller":"traceutil/trace.go:171","msg":"trace[1864691499] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"290.67553ms","start":"2026-02-12T03:40:55.75689Z","end":"2026-02-12T03:40:56.047566Z","steps":["trace[1864691499] 'process raft request'  (duration: 290.252471ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:41:05.036578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.88034ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101039853902660 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189362c23298198a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189362c23298198a\" value_size:692 lease:4098729002999126595 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:41:05.036654Z","caller":"traceutil/trace.go:171","msg":"trace[429174276] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"330.438784ms","start":"2026-02-12T03:41:04.706202Z","end":"2026-02-12T03:41:05.036641Z","steps":["trace[429174276] 'process raft request'  (duration: 166.453221ms)","trace[429174276] 'compare'  (duration: 163.787839ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:41:05.036687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:04.706179Z","time spent":"330.495425ms","remote":"127.0.0.1:54644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189362c23298198a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189362c23298198a\" value_size:692 lease:4098729002999126595 >> failure:<>"}
{"level":"info","ts":"2026-02-12T03:41:05.060797Z","caller":"traceutil/trace.go:171","msg":"trace[337339654] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"339.764378ms","start":"2026-02-12T03:41:04.721017Z","end":"2026-02-12T03:41:05.060781Z","steps":["trace[337339654] 'process raft request'  (duration: 339.714707ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:41:05.060894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:04.720992Z","time spent":"339.852109ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:957 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-02-12T03:41:05.06104Z","caller":"traceutil/trace.go:171","msg":"trace[417443803] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"342.059082ms","start":"2026-02-12T03:41:04.718974Z","end":"2026-02-12T03:41:05.061033Z","steps":["trace[417443803] 'process raft request'  (duration: 341.674753ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:41:05.061071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:04.718957Z","time spent":"342.097544ms","remote":"127.0.0.1:54644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-9mr5r.189362c233911117\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-9mr5r.189362c233911117\" value_size:685 lease:4098729002999126595 >> failure:<>"}
{"level":"warn","ts":"2026-02-12T03:41:05.532081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.311301ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101039853902663 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-9mr5r.189362c233c4604a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-9mr5r.189362c233c4604a\" value_size:711 lease:4098729002999126595 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-12T03:41:05.532155Z","caller":"traceutil/trace.go:171","msg":"trace[1810605406] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:995; }","duration":"427.105883ms","start":"2026-02-12T03:41:05.105037Z","end":"2026-02-12T03:41:05.532143Z","steps":["trace[1810605406] 'read index received'  (duration: 297.659009ms)","trace[1810605406] 'applied index is now lower than readState.Index'  (duration: 129.445044ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:41:05.532237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.183254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:41:05.532257Z","caller":"traceutil/trace.go:171","msg":"trace[1806177667] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:961; }","duration":"427.255396ms","start":"2026-02-12T03:41:05.104993Z","end":"2026-02-12T03:41:05.532249Z","steps":["trace[1806177667] 'agreement among raft nodes before linearized reading'  (duration: 427.179185ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:41:05.532278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:05.104974Z","time spent":"427.297716ms","remote":"127.0.0.1:46550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-02-12T03:41:05.532338Z","caller":"traceutil/trace.go:171","msg":"trace[2138499632] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"465.257626ms","start":"2026-02-12T03:41:05.067059Z","end":"2026-02-12T03:41:05.532317Z","steps":["trace[2138499632] 'process raft request'  (duration: 335.665679ms)","trace[2138499632] 'compare'  (duration: 129.172408ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:41:05.532432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:41:05.067046Z","time spent":"465.334439ms","remote":"127.0.0.1:54644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-9mr5r.189362c233c4604a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-795cfbf7fb-9mr5r.189362c233c4604a\" value_size:711 lease:4098729002999126595 >> failure:<>"}
{"level":"info","ts":"2026-02-12T03:42:43.862976Z","caller":"traceutil/trace.go:171","msg":"trace[192514671] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"399.452579ms","start":"2026-02-12T03:42:43.463507Z","end":"2026-02-12T03:42:43.86296Z","steps":["trace[192514671] 'process raft request'  (duration: 399.368727ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:43.863067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:43.463494Z","time spent":"399.52192ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1365 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-02-12T03:42:43.863299Z","caller":"traceutil/trace.go:171","msg":"trace[732306575] linearizableReadLoop","detail":"{readStateIndex:1443; appliedIndex:1443; }","duration":"182.224039ms","start":"2026-02-12T03:42:43.681068Z","end":"2026-02-12T03:42:43.863292Z","steps":["trace[732306575] 'read index received'  (duration: 182.219459ms)","trace[732306575] 'applied index is now lower than readState.Index'  (duration: 4.14µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:42:43.863334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.26456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:43.863349Z","caller":"traceutil/trace.go:171","msg":"trace[1346680331] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1388; }","duration":"182.334271ms","start":"2026-02-12T03:42:43.68101Z","end":"2026-02-12T03:42:43.863345Z","steps":["trace[1346680331] 'agreement among raft nodes before linearized reading'  (duration: 182.30408ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:42:44.903795Z","caller":"traceutil/trace.go:171","msg":"trace[709227839] linearizableReadLoop","detail":"{readStateIndex:1445; appliedIndex:1444; }","duration":"284.292889ms","start":"2026-02-12T03:42:44.61947Z","end":"2026-02-12T03:42:44.903763Z","steps":["trace[709227839] 'read index received'  (duration: 283.152292ms)","trace[709227839] 'applied index is now lower than readState.Index'  (duration: 1.139967ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:42:44.904115Z","caller":"traceutil/trace.go:171","msg":"trace[242654718] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"337.183035ms","start":"2026-02-12T03:42:44.566924Z","end":"2026-02-12T03:42:44.904107Z","steps":["trace[242654718] 'process raft request'  (duration: 335.7557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:44.904178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:42:44.566918Z","time spent":"337.212356ms","remote":"127.0.0.1:54824","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:1383 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-12T03:42:44.904339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.867003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-12T03:42:44.904356Z","caller":"traceutil/trace.go:171","msg":"trace[1784788887] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1390; }","duration":"284.917555ms","start":"2026-02-12T03:42:44.619433Z","end":"2026-02-12T03:42:44.904351Z","steps":["trace[1784788887] 'agreement among raft nodes before linearized reading'  (duration: 284.848693ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:44.904425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.711988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:42:44.904436Z","caller":"traceutil/trace.go:171","msg":"trace[570388858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1390; }","duration":"248.74673ms","start":"2026-02-12T03:42:44.655686Z","end":"2026-02-12T03:42:44.904432Z","steps":["trace[570388858] 'agreement among raft nodes before linearized reading'  (duration: 248.727759ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:44.904559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.829396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-02-12T03:42:44.904572Z","caller":"traceutil/trace.go:171","msg":"trace[1038543668] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1390; }","duration":"180.866887ms","start":"2026-02-12T03:42:44.723702Z","end":"2026-02-12T03:42:44.904569Z","steps":["trace[1038543668] 'agreement among raft nodes before linearized reading'  (duration: 180.824466ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:44.904651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.208357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-12T03:42:44.904664Z","caller":"traceutil/trace.go:171","msg":"trace[840327502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1390; }","duration":"215.233558ms","start":"2026-02-12T03:42:44.689427Z","end":"2026-02-12T03:42:44.904661Z","steps":["trace[840327502] 'agreement among raft nodes before linearized reading'  (duration: 215.194477ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:42:44.904738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.714988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-12T03:42:44.904751Z","caller":"traceutil/trace.go:171","msg":"trace[1032236493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1390; }","duration":"217.750259ms","start":"2026-02-12T03:42:44.686996Z","end":"2026-02-12T03:42:44.904746Z","steps":["trace[1032236493] 'agreement among raft nodes before linearized reading'  (duration: 217.712958ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:17.157314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853904742,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:17.65791Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853904742,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:18.055215Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.545760361s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T03:44:18.055987Z","caller":"traceutil/trace.go:171","msg":"trace[300029070] transaction","detail":"{read_only:false; response_revision:1780; number_of_response:1; }","duration":"1.546621522s","start":"2026-02-12T03:44:16.509334Z","end":"2026-02-12T03:44:18.055956Z","steps":["trace[300029070] 'process raft request'  (duration: 1.546426317s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.056331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:16.509309Z","time spent":"1.546762786s","remote":"127.0.0.1:54728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1768,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/default/test-pvc-pod\" mod_revision:1758 > success:<request_put:<key:\"/registry/pods/default/test-pvc-pod\" value_size:1725 >> failure:<request_range:<key:\"/registry/pods/default/test-pvc-pod\" > >"}
{"level":"info","ts":"2026-02-12T03:44:18.057044Z","caller":"traceutil/trace.go:171","msg":"trace[1019704544] linearizableReadLoop","detail":"{readStateIndex:1856; appliedIndex:1855; }","duration":"1.400550736s","start":"2026-02-12T03:44:16.656472Z","end":"2026-02-12T03:44:18.057023Z","steps":["trace[1019704544] 'read index received'  (duration: 1.399791187s)","trace[1019704544] 'applied index is now lower than readState.Index'  (duration: 758.549µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T03:44:18.061122Z","caller":"traceutil/trace.go:171","msg":"trace[535577366] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"1.345230655s","start":"2026-02-12T03:44:16.712306Z","end":"2026-02-12T03:44:18.057536Z","steps":["trace[535577366] 'process raft request'  (duration: 1.34456518s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.061685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:16.71229Z","time spent":"1.349182909s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1725 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-12T03:44:18.062044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405570715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:44:18.062296Z","caller":"traceutil/trace.go:171","msg":"trace[1907406521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1781; }","duration":"1.405797381s","start":"2026-02-12T03:44:16.656433Z","end":"2026-02-12T03:44:18.062231Z","steps":["trace[1907406521] 'agreement among raft nodes before linearized reading'  (duration: 1.405585186s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.062348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:16.65642Z","time spent":"1.405917513s","remote":"127.0.0.1:54576","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-02-12T03:44:18.062636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078984201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-12T03:44:18.06268Z","caller":"traceutil/trace.go:171","msg":"trace[1911391851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1781; }","duration":"1.079062173s","start":"2026-02-12T03:44:16.98361Z","end":"2026-02-12T03:44:18.062672Z","steps":["trace[1911391851] 'agreement among raft nodes before linearized reading'  (duration: 1.078857088s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.062715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:16.983589Z","time spent":"1.079119464s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.062908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.189687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-12T03:44:18.063066Z","caller":"traceutil/trace.go:171","msg":"trace[504918542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1781; }","duration":"490.344571ms","start":"2026-02-12T03:44:17.572712Z","end":"2026-02-12T03:44:18.063057Z","steps":["trace[504918542] 'agreement among raft nodes before linearized reading'  (duration: 490.147567ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.063114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.572683Z","time spent":"490.423363ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.063383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.805847ms","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-02-12T03:44:18.063427Z","caller":"traceutil/trace.go:171","msg":"trace[1910033177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1781; }","duration":"491.886759ms","start":"2026-02-12T03:44:17.571532Z","end":"2026-02-12T03:44:18.063419Z","steps":["trace[1910033177] 'agreement among raft nodes before linearized reading'  (duration: 491.802657ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.063461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.571522Z","time spent":"491.93342ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.063699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.608814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-02-12T03:44:18.063764Z","caller":"traceutil/trace.go:171","msg":"trace[1168930629] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1781; }","duration":"564.701527ms","start":"2026-02-12T03:44:17.499055Z","end":"2026-02-12T03:44:18.063757Z","steps":["trace[1168930629] 'agreement among raft nodes before linearized reading'  (duration: 564.496572ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.063817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.499046Z","time spent":"564.764338ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.064062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.143348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-02-12T03:44:18.064311Z","caller":"traceutil/trace.go:171","msg":"trace[1744816623] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1781; }","duration":"578.424204ms","start":"2026-02-12T03:44:17.48588Z","end":"2026-02-12T03:44:18.064304Z","steps":["trace[1744816623] 'agreement among raft nodes before linearized reading'  (duration: 578.118917ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.064347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.48587Z","time spent":"578.470025ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.06448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.394967ms","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-02-12T03:44:18.064569Z","caller":"traceutil/trace.go:171","msg":"trace[356479542] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1781; }","duration":"602.481679ms","start":"2026-02-12T03:44:17.462079Z","end":"2026-02-12T03:44:18.064561Z","steps":["trace[356479542] 'agreement among raft nodes before linearized reading'  (duration: 602.379117ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.064609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.462039Z","time spent":"602.562941ms","remote":"127.0.0.1:54728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1806,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.06597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.579786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-02-12T03:44:18.066602Z","caller":"traceutil/trace.go:171","msg":"trace[643901782] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1781; }","duration":"615.252283ms","start":"2026-02-12T03:44:17.451339Z","end":"2026-02-12T03:44:18.066591Z","steps":["trace[643901782] 'agreement among raft nodes before linearized reading'  (duration: 614.572966ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.066701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.451319Z","time spent":"615.372056ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.067018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.856959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-02-12T03:44:18.067063Z","caller":"traceutil/trace.go:171","msg":"trace[976189697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1781; }","duration":"742.935211ms","start":"2026-02-12T03:44:17.324121Z","end":"2026-02-12T03:44:18.067056Z","steps":["trace[976189697] 'agreement among raft nodes before linearized reading'  (duration: 742.691455ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.067099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:17.324105Z","time spent":"742.987253ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:44:18.067215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070026488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T03:44:18.067255Z","caller":"traceutil/trace.go:171","msg":"trace[2009462288] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1781; }","duration":"1.070095329s","start":"2026-02-12T03:44:16.997151Z","end":"2026-02-12T03:44:18.067246Z","steps":["trace[2009462288] 'agreement among raft nodes before linearized reading'  (duration: 1.070039888s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:18.06729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:16.997137Z","time spent":"1.07014563s","remote":"127.0.0.1:55022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-02-12T03:44:29.788693Z","caller":"traceutil/trace.go:171","msg":"trace[109825164] linearizableReadLoop","detail":"{readStateIndex:1924; appliedIndex:1923; }","duration":"133.593318ms","start":"2026-02-12T03:44:29.655077Z","end":"2026-02-12T03:44:29.788671Z","steps":["trace[109825164] 'read index received'  (duration: 133.417184ms)","trace[109825164] 'applied index is now lower than readState.Index'  (duration: 175.274µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:29.788817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.720261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T03:44:29.78886Z","caller":"traceutil/trace.go:171","msg":"trace[1708442154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1847; }","duration":"133.836625ms","start":"2026-02-12T03:44:29.655013Z","end":"2026-02-12T03:44:29.78885Z","steps":["trace[1708442154] 'agreement among raft nodes before linearized reading'  (duration: 133.741522ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:29.78907Z","caller":"traceutil/trace.go:171","msg":"trace[1615032553] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"381.67944ms","start":"2026-02-12T03:44:29.40738Z","end":"2026-02-12T03:44:29.789059Z","steps":["trace[1615032553] 'process raft request'  (duration: 381.164637ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:29.789187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:29.407357Z","time spent":"381.761492ms","remote":"127.0.0.1:54824","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:1797 > 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-02-12T03:44:55.996895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853905848,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:56.497553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853905848,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:56.998683Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853905848,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:57.499612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101039853905848,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T03:44:57.533006Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.062182246s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T03:44:57.533759Z","caller":"traceutil/trace.go:171","msg":"trace[782228518] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"2.062942135s","start":"2026-02-12T03:44:55.470765Z","end":"2026-02-12T03:44:57.533707Z","steps":["trace[782228518] 'process raft request'  (duration: 2.062791101s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.534079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:55.470755Z","time spent":"2.063044027s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1944 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-02-12T03:44:57.537947Z","caller":"traceutil/trace.go:171","msg":"trace[558988666] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2042; }","duration":"2.041845481s","start":"2026-02-12T03:44:55.496076Z","end":"2026-02-12T03:44:57.537921Z","steps":["trace[558988666] 'read index received'  (duration: 2.037436436s)","trace[558988666] 'applied index is now lower than readState.Index'  (duration: 4.407494ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T03:44:57.538095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.042006465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-xrlqt\" ","response":"range_response_count:1 size:4411"}
{"level":"info","ts":"2026-02-12T03:44:57.538132Z","caller":"traceutil/trace.go:171","msg":"trace[642838406] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-xrlqt; range_end:; response_count:1; response_revision:1961; }","duration":"2.042095507s","start":"2026-02-12T03:44:55.49602Z","end":"2026-02-12T03:44:57.538122Z","steps":["trace[642838406] 'agreement among raft nodes before linearized reading'  (duration: 2.042009935s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.538187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:55.496005Z","time spent":"2.042173579s","remote":"127.0.0.1:54728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4434,"request content":"key:\"/registry/pods/kube-system/kube-proxy-xrlqt\" "}
{"level":"warn","ts":"2026-02-12T03:44:57.538417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.041587664s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4064"}
{"level":"info","ts":"2026-02-12T03:44:57.53847Z","caller":"traceutil/trace.go:171","msg":"trace[955110216] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:1961; }","duration":"2.041641726s","start":"2026-02-12T03:44:55.49682Z","end":"2026-02-12T03:44:57.538461Z","steps":["trace[955110216] 'agreement among raft nodes before linearized reading'  (duration: 2.041555463s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.538616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:55.496781Z","time spent":"2.04182339s","remote":"127.0.0.1:54728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4087,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-02-12T03:44:57.538833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184651782s","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-02-12T03:44:57.53888Z","caller":"traceutil/trace.go:171","msg":"trace[522973473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1961; }","duration":"1.184712665s","start":"2026-02-12T03:44:56.354159Z","end":"2026-02-12T03:44:57.538872Z","steps":["trace[522973473] 'agreement among raft nodes before linearized reading'  (duration: 1.184547671s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.538998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:56.354152Z","time spent":"1.184749105s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-12T03:44:57.539503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205234723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-12T03:44:57.539557Z","caller":"traceutil/trace.go:171","msg":"trace[1695226423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1961; }","duration":"1.205305655s","start":"2026-02-12T03:44:56.334241Z","end":"2026-02-12T03:44:57.539546Z","steps":["trace[1695226423] 'agreement among raft nodes before linearized reading'  (duration: 1.204914006s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.539588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:56.334235Z","time spent":"1.205344396s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T03:44:57.540306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.759884121s","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":"warn","ts":"2026-02-12T03:44:57.542529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.997896821s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-02-12T03:44:57.548828Z","caller":"traceutil/trace.go:171","msg":"trace[262704170] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1961; }","duration":"2.004222923s","start":"2026-02-12T03:44:55.544585Z","end":"2026-02-12T03:44:57.548808Z","steps":["trace[262704170] 'agreement among raft nodes before linearized reading'  (duration: 1.996492609s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.549005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:55.544573Z","time spent":"2.004387237s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-02-12T03:44:57.542621Z","caller":"traceutil/trace.go:171","msg":"trace[659192646] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1961; }","duration":"1.762051842s","start":"2026-02-12T03:44:55.780373Z","end":"2026-02-12T03:44:57.542425Z","steps":["trace[659192646] 'agreement among raft nodes before linearized reading'  (duration: 1.75985816s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.541034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.884862444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-12T03:44:57.546015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296987974s","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-02-12T03:44:57.546144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232065164s","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":"warn","ts":"2026-02-12T03:44:57.546308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299690688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-02-12T03:44:57.548742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215283424s","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":"warn","ts":"2026-02-12T03:44:57.549747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:55.780357Z","time spent":"1.769367678s","remote":"127.0.0.1:52132","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":"info","ts":"2026-02-12T03:44:57.550692Z","caller":"traceutil/trace.go:171","msg":"trace[1914783210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1961; }","duration":"1.304116954s","start":"2026-02-12T03:44:56.246565Z","end":"2026-02-12T03:44:57.550682Z","steps":["trace[1914783210] 'agreement among raft nodes before linearized reading'  (duration: 1.299639237s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.55212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:56.246546Z","time spent":"1.305561178s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-12T03:44:57.550929Z","caller":"traceutil/trace.go:171","msg":"trace[1814768080] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1961; }","duration":"1.236870778s","start":"2026-02-12T03:44:56.314046Z","end":"2026-02-12T03:44:57.550917Z","steps":["trace[1814768080] 'agreement among raft nodes before linearized reading'  (duration: 1.232004062s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.552832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:56.314036Z","time spent":"1.238768955s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-12T03:44:57.55031Z","caller":"traceutil/trace.go:171","msg":"trace[382783018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1961; }","duration":"1.301329669s","start":"2026-02-12T03:44:56.248973Z","end":"2026-02-12T03:44:57.550302Z","steps":["trace[382783018] 'agreement among raft nodes before linearized reading'  (duration: 1.296866671s)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:57.55097Z","caller":"traceutil/trace.go:171","msg":"trace[785871334] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1961; }","duration":"1.217555898s","start":"2026-02-12T03:44:56.333404Z","end":"2026-02-12T03:44:57.55096Z","steps":["trace[785871334] 'agreement among raft nodes before linearized reading'  (duration: 1.209248679s)"],"step_count":1}
{"level":"info","ts":"2026-02-12T03:44:57.550214Z","caller":"traceutil/trace.go:171","msg":"trace[781732256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1961; }","duration":"1.894095495s","start":"2026-02-12T03:44:55.656108Z","end":"2026-02-12T03:44:57.550204Z","steps":["trace[781732256] 'agreement among raft nodes before linearized reading'  (duration: 1.884842854s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T03:44:57.553274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:56.24892Z","time spent":"1.30434495s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T03:44:57.554053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:56.333396Z","time spent":"1.220619631s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-02-12T03:44:57.55507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:44:55.656076Z","time spent":"1.898984802s","remote":"127.0.0.1:54576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}