{"level":"warn","ts":"2026-02-04T05:12:01.641069Z","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-04T05:12:01.641386Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-04T05:12:01.641535Z","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-04T05:12:01.641606Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]}
{"level":"info","ts":"2026-02-04T05:12:01.641688Z","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-04T05:12:01.642456Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]}
{"level":"info","ts":"2026-02-04T05:12:01.642614Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-04T05:12:01.647471Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.533912ms"}
{"level":"info","ts":"2026-02-04T05:12:01.687038Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"}
{"level":"info","ts":"2026-02-04T05:12:01.687362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"}
{"level":"info","ts":"2026-02-04T05:12:01.688387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"}
{"level":"info","ts":"2026-02-04T05:12:01.688454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-04T05:12:01.688662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"}
{"level":"info","ts":"2026-02-04T05:12:01.689305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"}
{"level":"warn","ts":"2026-02-04T05:12:01.702407Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-04T05:12:01.707051Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-04T05:12:01.709694Z","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-04T05:12:01.715915Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-04T05:12:01.716715Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-04T05:12:01.717292Z","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-04T05:12:01.717384Z","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-04T05:12:01.717448Z","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-04T05:12:01.717713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"}
{"level":"info","ts":"2026-02-04T05:12:01.717854Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]}
{"level":"info","ts":"2026-02-04T05:12:01.727205Z","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-04T05:12:01.728405Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-04T05:12:01.728552Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-04T05:12:01.728658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"}
{"level":"info","ts":"2026-02-04T05:12:01.728774Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"}
{"level":"info","ts":"2026-02-04T05:12:01.991593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"}
{"level":"info","ts":"2026-02-04T05:12:01.99177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-04T05:12:01.991858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"}
{"level":"info","ts":"2026-02-04T05:12:01.99192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"}
{"level":"info","ts":"2026-02-04T05:12:01.991951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"}
{"level":"info","ts":"2026-02-04T05:12:01.992005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"}
{"level":"info","ts":"2026-02-04T05:12:01.992031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"}
{"level":"info","ts":"2026-02-04T05:12:01.993524Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T05:12:01.994602Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-04T05:12:01.995058Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T05:12:01.995068Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T05:12:01.995283Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T05:12:01.995366Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T05:12:01.995458Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T05:12:02.003636Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-04T05:12:02.010474Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"}
{"level":"info","ts":"2026-02-04T05:12:02.012733Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-04T05:12:02.012852Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"warn","ts":"2026-02-04T05:12:10.701836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555603608715631778,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T05:12:11.202775Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555603608715631778,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T05:12:11.215149Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.143671387s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-04T05:12:11.215958Z","caller":"traceutil/trace.go:171","msg":"trace[1052285988] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:298; }","duration":"1.014271105s","start":"2026-02-04T05:12:10.201658Z","end":"2026-02-04T05:12:11.215929Z","steps":["trace[1052285988] 'read index received'  (duration: 1.013989602s)","trace[1052285988] 'applied index is now lower than readState.Index'  (duration: 280.533µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T05:12:11.216236Z","caller":"traceutil/trace.go:171","msg":"trace[155694813] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"1.144837599s","start":"2026-02-04T05:12:10.071389Z","end":"2026-02-04T05:12:11.216226Z","steps":["trace[155694813] 'process raft request'  (duration: 1.144356554s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.216738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:10.071366Z","time spent":"1.14489538s","remote":"127.0.0.1:51086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" value_size:129 >> failure:<>"}
{"level":"warn","ts":"2026-02-04T05:12:11.216973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015304566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-04T05:12:11.217004Z","caller":"traceutil/trace.go:171","msg":"trace[296888905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:286; }","duration":"1.015344426s","start":"2026-02-04T05:12:10.201651Z","end":"2026-02-04T05:12:11.216995Z","steps":["trace[296888905] 'agreement among raft nodes before linearized reading'  (duration: 1.015241405s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.217025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:10.201597Z","time spent":"1.015424366s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T05:12:11.217143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014020242s","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-04T05:12:11.217161Z","caller":"traceutil/trace.go:171","msg":"trace[1330958164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:286; }","duration":"1.014077493s","start":"2026-02-04T05:12:10.203077Z","end":"2026-02-04T05:12:11.217155Z","steps":["trace[1330958164] 'agreement among raft nodes before linearized reading'  (duration: 1.014043912s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.217177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:10.203053Z","time spent":"1.014120684s","remote":"127.0.0.1:51160","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-04T05:12:11.217303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.720789ms","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-04T05:12:11.217323Z","caller":"traceutil/trace.go:171","msg":"trace[1054439505] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:286; }","duration":"687.76073ms","start":"2026-02-04T05:12:10.529557Z","end":"2026-02-04T05:12:11.217317Z","steps":["trace[1054439505] 'agreement among raft nodes before linearized reading'  (duration: 687.72273ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.21734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:10.52954Z","time spent":"687.79646ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-04T05:12:11.668595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.853392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T05:12:11.668701Z","caller":"traceutil/trace.go:171","msg":"trace[338923790] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:286; }","duration":"442.020973ms","start":"2026-02-04T05:12:11.226655Z","end":"2026-02-04T05:12:11.668676Z","steps":["trace[338923790] 'range keys from in-memory index tree'  (duration: 441.777201ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.668773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:11.226632Z","time spent":"442.130105ms","remote":"127.0.0.1:51086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"info","ts":"2026-02-04T05:12:11.669043Z","caller":"traceutil/trace.go:171","msg":"trace[898924528] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"441.853682ms","start":"2026-02-04T05:12:11.227156Z","end":"2026-02-04T05:12:11.66901Z","steps":["trace[898924528] 'process raft request'  (duration: 426.047422ms)","trace[898924528] 'compare'  (duration: 15.197054ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T05:12:11.670526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:11.227142Z","time spent":"441.987683ms","remote":"127.0.0.1:51160","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:267 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-04T05:12:11.67192Z","caller":"traceutil/trace.go:171","msg":"trace[1200021999] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:299; }","duration":"182.588074ms","start":"2026-02-04T05:12:11.489286Z","end":"2026-02-04T05:12:11.671874Z","steps":["trace[1200021999] 'read index received'  (duration: 163.934405ms)","trace[1200021999] 'applied index is now lower than readState.Index'  (duration: 18.653059ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T05:12:11.672156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.867886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T05:12:11.672295Z","caller":"traceutil/trace.go:171","msg":"trace[1284071877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:289; }","duration":"183.039969ms","start":"2026-02-04T05:12:11.489242Z","end":"2026-02-04T05:12:11.672282Z","steps":["trace[1284071877] 'agreement among raft nodes before linearized reading'  (duration: 182.798296ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:12:11.673532Z","caller":"traceutil/trace.go:171","msg":"trace[1706247552] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"443.361357ms","start":"2026-02-04T05:12:11.230151Z","end":"2026-02-04T05:12:11.673512Z","steps":["trace[1706247552] 'process raft request'  (duration: 441.68092ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.673673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:11.230142Z","time spent":"443.444868ms","remote":"127.0.0.1:51160","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:262 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-04T05:12:11.673055Z","caller":"traceutil/trace.go:171","msg":"trace[301030960] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"443.881543ms","start":"2026-02-04T05:12:11.229156Z","end":"2026-02-04T05:12:11.673037Z","steps":["trace[301030960] 'process raft request'  (duration: 442.447828ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:11.675408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:11.229146Z","time spent":"445.075555ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:261 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-04T05:12:42.573242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.819368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T05:12:42.573324Z","caller":"traceutil/trace.go:171","msg":"trace[348007178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"129.943929ms","start":"2026-02-04T05:12:42.443361Z","end":"2026-02-04T05:12:42.573305Z","steps":["trace[348007178] 'range keys from in-memory index tree'  (duration: 129.748187ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:12:43.157289Z","caller":"traceutil/trace.go:171","msg":"trace[1168551895] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"435.675818ms","start":"2026-02-04T05:12:42.721563Z","end":"2026-02-04T05:12:43.157239Z","steps":["trace[1168551895] 'process raft request'  (duration: 435.575577ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:43.157383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:42.721547Z","time spent":"435.788049ms","remote":"127.0.0.1:51076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-mhtxx\" mod_revision:462 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-mhtxx\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-mhtxx\" > >"}
{"level":"warn","ts":"2026-02-04T05:12:44.364107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555603608715632278,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T05:12:44.865003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555603608715632278,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T05:12:45.365854Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555603608715632278,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T05:12:45.681837Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.858463226s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-04T05:12:45.682296Z","caller":"traceutil/trace.go:171","msg":"trace[721491160] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.85898225s","start":"2026-02-04T05:12:43.823299Z","end":"2026-02-04T05:12:45.682281Z","steps":["trace[721491160] 'process raft request'  (duration: 1.85888937s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:45.682373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:43.823286Z","time spent":"1.859035271s","remote":"127.0.0.1:51160","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:525 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-04T05:12:45.728296Z","caller":"traceutil/trace.go:171","msg":"trace[1425374548] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:550; }","duration":"1.865510807s","start":"2026-02-04T05:12:43.862764Z","end":"2026-02-04T05:12:45.728275Z","steps":["trace[1425374548] 'read index received'  (duration: 1.819380281s)","trace[1425374548] 'applied index is now lower than readState.Index'  (duration: 46.129726ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T05:12:45.728535Z","caller":"traceutil/trace.go:171","msg":"trace[1427821124] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"532.786251ms","start":"2026-02-04T05:12:45.195742Z","end":"2026-02-04T05:12:45.728528Z","steps":["trace[1427821124] 'process raft request'  (duration: 532.443849ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:45.728616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:45.195719Z","time spent":"532.844922ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:485 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-04T05:12:45.728742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.865981401s","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-04T05:12:45.728772Z","caller":"traceutil/trace.go:171","msg":"trace[1719542232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"1.866030701s","start":"2026-02-04T05:12:43.862735Z","end":"2026-02-04T05:12:45.728766Z","steps":["trace[1719542232] 'agreement among raft nodes before linearized reading'  (duration: 1.865982831s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:45.728791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:43.862697Z","time spent":"1.866089511s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-04T05:12:45.728882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.865469087s","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-04T05:12:45.728898Z","caller":"traceutil/trace.go:171","msg":"trace[1806290992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"1.865513107s","start":"2026-02-04T05:12:43.86338Z","end":"2026-02-04T05:12:45.728893Z","steps":["trace[1806290992] 'agreement among raft nodes before linearized reading'  (duration: 1.865485617s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:45.728914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:43.863364Z","time spent":"1.865545917s","remote":"127.0.0.1:51160","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-04T05:12:45.729142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.285311741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T05:12:45.729162Z","caller":"traceutil/trace.go:171","msg":"trace[1160932551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"1.285330261s","start":"2026-02-04T05:12:44.443825Z","end":"2026-02-04T05:12:45.729155Z","steps":["trace[1160932551] 'agreement among raft nodes before linearized reading'  (duration: 1.285304061s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:45.729177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:44.44379Z","time spent":"1.285384171s","remote":"127.0.0.1:50900","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-04T05:12:45.729761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.659865426s","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-04T05:12:45.729786Z","caller":"traceutil/trace.go:171","msg":"trace[1497617745] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"1.659927667s","start":"2026-02-04T05:12:44.069852Z","end":"2026-02-04T05:12:45.72978Z","steps":["trace[1497617745] 'agreement among raft nodes before linearized reading'  (duration: 1.659872036s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T05:12:45.729805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T05:12:44.069838Z","time spent":"1.659962437s","remote":"127.0.0.1:51160","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":"info","ts":"2026-02-04T05:12:50.146018Z","caller":"traceutil/trace.go:171","msg":"trace[1759546132] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"262.400471ms","start":"2026-02-04T05:12:49.883601Z","end":"2026-02-04T05:12:50.146001Z","steps":["trace[1759546132] 'process raft request'  (duration: 262.30645ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:12:50.189808Z","caller":"traceutil/trace.go:171","msg":"trace[1039390526] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"269.727695ms","start":"2026-02-04T05:12:49.920063Z","end":"2026-02-04T05:12:50.189791Z","steps":["trace[1039390526] 'process raft request'  (duration: 269.610194ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:13:04.391352Z","caller":"traceutil/trace.go:171","msg":"trace[167516882] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"145.126232ms","start":"2026-02-04T05:13:04.246211Z","end":"2026-02-04T05:13:04.391337Z","steps":["trace[167516882] 'process raft request'  (duration: 144.815046ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:13:10.227249Z","caller":"traceutil/trace.go:171","msg":"trace[289942587] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:771; }","duration":"147.365176ms","start":"2026-02-04T05:13:10.079868Z","end":"2026-02-04T05:13:10.227233Z","steps":["trace[289942587] 'read index received'  (duration: 147.23038ms)","trace[289942587] 'applied index is now lower than readState.Index'  (duration: 134.076µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T05:13:10.227391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.500003ms","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-04T05:13:10.227429Z","caller":"traceutil/trace.go:171","msg":"trace[795621182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:745; }","duration":"147.571805ms","start":"2026-02-04T05:13:10.07985Z","end":"2026-02-04T05:13:10.227422Z","steps":["trace[795621182] 'agreement among raft nodes before linearized reading'  (duration: 147.445519ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:13:10.227644Z","caller":"traceutil/trace.go:171","msg":"trace[1204099563] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"148.338351ms","start":"2026-02-04T05:13:10.0793Z","end":"2026-02-04T05:13:10.227639Z","steps":["trace[1204099563] 'process raft request'  (duration: 147.851649ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:13:10.371551Z","caller":"traceutil/trace.go:171","msg":"trace[792885140] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"134.286464ms","start":"2026-02-04T05:13:10.237244Z","end":"2026-02-04T05:13:10.37153Z","steps":["trace[792885140] 'process raft request'  (duration: 134.165518ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T05:14:06.439162Z","caller":"traceutil/trace.go:171","msg":"trace[1633501130] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"234.645945ms","start":"2026-02-04T05:14:06.204493Z","end":"2026-02-04T05:14:06.439139Z","steps":["trace[1633501130] 'process raft request'  (duration: 234.47319ms)"],"step_count":1}